{"level":"warn","ts":"2026-02-17T23:10:46.638262Z","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-17T23:10:46.638483Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.195: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.195:2380","--initial-cluster=instance=https://162.253.55.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.195: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-17T23:10:46.638597Z","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-17T23:10:46.638633Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-02-17T23:10:46.638676Z","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-17T23:10:46.63939Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"]} {"level":"info","ts":"2026-02-17T23:10:46.640075Z","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.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.195: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-17T23:10:46.647558Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.505751ms"} {"level":"info","ts":"2026-02-17T23:10:46.657417Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b66d12fd59101739","cluster-id":"a64a525934ce8379"} {"level":"info","ts":"2026-02-17T23:10:46.657595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T23:10:46.657676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 0"} {"level":"info","ts":"2026-02-17T23:10:46.657731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b66d12fd59101739 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T23:10:46.657756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 1"} {"level":"info","ts":"2026-02-17T23:10:46.65783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"warn","ts":"2026-02-17T23:10:46.664842Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T23:10:46.670287Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T23:10:46.674407Z","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-17T23:10:46.681279Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b66d12fd59101739","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T23:10:46.683401Z","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-17T23:10:46.683661Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b66d12fd59101739","initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T23:10:46.683702Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T23:10:46.684423Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-02-17T23:10:46.684464Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-02-17T23:10:46.685578Z","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-17T23:10:46.685633Z","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-17T23:10:46.685664Z","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-17T23:10:46.684314Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b66d12fd59101739","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T23:10:46.689889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"info","ts":"2026-02-17T23:10:46.690042Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","added-peer-id":"b66d12fd59101739","added-peer-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-02-17T23:10:47.259056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T23:10:47.259218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T23:10:47.259275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgPreVoteResp from b66d12fd59101739 at term 1"} {"level":"info","ts":"2026-02-17T23:10:47.259323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became candidate at term 2"} {"level":"info","ts":"2026-02-17T23:10:47.259332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgVoteResp from b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-02-17T23:10:47.25934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became leader at term 2"} {"level":"info","ts":"2026-02-17T23:10:47.259347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b66d12fd59101739 elected leader b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-02-17T23:10:47.2611Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b66d12fd59101739","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.195:2379]}","request-path":"/0/members/b66d12fd59101739/attributes","cluster-id":"a64a525934ce8379","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T23:10:47.261275Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T23:10:47.261948Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:10:47.262095Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T23:10:47.264772Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.195:2379"} {"level":"info","ts":"2026-02-17T23:10:47.271486Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T23:10:47.271503Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T23:10:47.271538Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-17T23:10:47.271894Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:10:47.271949Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:10:47.271969Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:10:56.619184Z","caller":"traceutil/trace.go:171","msg":"trace[432766752] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"286.071089ms","start":"2026-02-17T23:10:56.333104Z","end":"2026-02-17T23:10:56.619175Z","steps":["trace[432766752] 'process raft request' (duration: 211.277ms)","trace[432766752] 'compare' (duration: 74.393568ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:10:56.619484Z","caller":"traceutil/trace.go:171","msg":"trace[882362071] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"281.367796ms","start":"2026-02-17T23:10:56.338109Z","end":"2026-02-17T23:10:56.619477Z","steps":["trace[882362071] 'process raft request' (duration: 280.78016ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:56.620031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.385658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-02-17T23:10:56.620059Z","caller":"traceutil/trace.go:171","msg":"trace[1061790974] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:314; }","duration":"234.445311ms","start":"2026-02-17T23:10:56.385605Z","end":"2026-02-17T23:10:56.62005Z","steps":["trace[1061790974] 'agreement among raft nodes before linearized reading' (duration: 234.374749ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:56.619066Z","caller":"traceutil/trace.go:171","msg":"trace[1358972669] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:320; }","duration":"233.430873ms","start":"2026-02-17T23:10:56.385622Z","end":"2026-02-17T23:10:56.619052Z","steps":["trace[1358972669] 'read index received' (duration: 158.713977ms)","trace[1358972669] 'applied index is now lower than readState.Index' (duration: 74.716336ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:10:56.840804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.678849ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:10:56.841219Z","caller":"traceutil/trace.go:171","msg":"trace[917404586] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:322; }","duration":"220.652847ms","start":"2026-02-17T23:10:56.620227Z","end":"2026-02-17T23:10:56.84088Z","steps":["trace[917404586] 'read index received' (duration: 108.478744ms)","trace[917404586] 'applied index is now lower than readState.Index' (duration: 112.172993ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:10:56.84175Z","caller":"traceutil/trace.go:171","msg":"trace[480425343] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"453.953786ms","start":"2026-02-17T23:10:56.38762Z","end":"2026-02-17T23:10:56.841574Z","steps":["trace[480425343] 'process raft request' (duration: 341.074085ms)","trace[480425343] 'compare' (duration: 111.549396ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:10:56.842453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.387598Z","time spent":"454.267605ms","remote":"127.0.0.1:35764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T23:10:56.843074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.72649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-17T23:10:56.843285Z","caller":"traceutil/trace.go:171","msg":"trace[1020781122] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:315; }","duration":"271.780981ms","start":"2026-02-17T23:10:56.57133Z","end":"2026-02-17T23:10:56.843111Z","steps":["trace[1020781122] 'agreement among raft nodes before linearized reading' (duration: 271.671458ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:56.843901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.127453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-17T23:10:56.843986Z","caller":"traceutil/trace.go:171","msg":"trace[1054961625] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:315; }","duration":"323.238046ms","start":"2026-02-17T23:10:56.520716Z","end":"2026-02-17T23:10:56.843954Z","steps":["trace[1054961625] 'agreement among raft nodes before linearized reading' (duration: 323.073782ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:56.844021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.520705Z","time spent":"323.308928ms","remote":"127.0.0.1:54070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-02-17T23:10:56.844065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.50522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-17T23:10:56.844108Z","caller":"traceutil/trace.go:171","msg":"trace[608331579] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:315; }","duration":"362.581191ms","start":"2026-02-17T23:10:56.481515Z","end":"2026-02-17T23:10:56.844096Z","steps":["trace[608331579] 'agreement among raft nodes before linearized reading' (duration: 362.500189ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:56.84414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.4815Z","time spent":"362.633313ms","remote":"127.0.0.1:54070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-02-17T23:10:56.844434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.160842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-02-17T23:10:56.84446Z","caller":"traceutil/trace.go:171","msg":"trace[1386451261] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:315; }","duration":"424.221364ms","start":"2026-02-17T23:10:56.420232Z","end":"2026-02-17T23:10:56.844453Z","steps":["trace[1386451261] 'agreement among raft nodes before linearized reading' (duration: 424.175512ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:56.844478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.420217Z","time spent":"424.257575ms","remote":"127.0.0.1:54070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-02-17T23:10:56.856763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.281175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-17T23:10:56.85679Z","caller":"traceutil/trace.go:171","msg":"trace[643356627] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:317; }","duration":"234.336096ms","start":"2026-02-17T23:10:56.622448Z","end":"2026-02-17T23:10:56.856784Z","steps":["trace[643356627] 'agreement among raft nodes before linearized reading' (duration: 234.287605ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:56.856985Z","caller":"traceutil/trace.go:171","msg":"trace[1006842646] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"233.986627ms","start":"2026-02-17T23:10:56.622976Z","end":"2026-02-17T23:10:56.856962Z","steps":["trace[1006842646] 'process raft request' (duration: 233.692919ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:56.85715Z","caller":"traceutil/trace.go:171","msg":"trace[393838937] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"230.289341ms","start":"2026-02-17T23:10:56.626856Z","end":"2026-02-17T23:10:56.857145Z","steps":["trace[393838937] 'process raft request' (duration: 229.856579ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:56.857299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.430268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:10:56.857322Z","caller":"traceutil/trace.go:171","msg":"trace[1910722583] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:317; }","duration":"134.475179ms","start":"2026-02-17T23:10:56.722841Z","end":"2026-02-17T23:10:56.857316Z","steps":["trace[1910722583] 'agreement among raft nodes before linearized reading' (duration: 134.422428ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:56.857452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.330245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-17T23:10:56.857521Z","caller":"traceutil/trace.go:171","msg":"trace[683019316] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:317; }","duration":"186.384005ms","start":"2026-02-17T23:10:56.671081Z","end":"2026-02-17T23:10:56.857465Z","steps":["trace[683019316] 'agreement among raft nodes before linearized reading' (duration: 186.351264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.257195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.224454ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:10:57.257429Z","caller":"traceutil/trace.go:171","msg":"trace[2020338632] linearizableReadLoop","detail":"{readStateIndex:332; appliedIndex:325; }","duration":"369.264438ms","start":"2026-02-17T23:10:56.888154Z","end":"2026-02-17T23:10:57.257419Z","steps":["trace[2020338632] 'read index received' (duration: 20.344875ms)","trace[2020338632] 'applied index is now lower than readState.Index' (duration: 348.919063ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:10:57.25747Z","caller":"traceutil/trace.go:171","msg":"trace[998871653] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"374.121976ms","start":"2026-02-17T23:10:56.883343Z","end":"2026-02-17T23:10:57.257465Z","steps":["trace[998871653] 'process raft request' (duration: 373.916031ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:57.257451Z","caller":"traceutil/trace.go:171","msg":"trace[387804925] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"374.111736ms","start":"2026-02-17T23:10:56.883313Z","end":"2026-02-17T23:10:57.257425Z","steps":["trace[387804925] 'process raft request' (duration: 139.616045ms)","trace[387804925] 'compare' (duration: 234.124542ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:10:57.257497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.88334Z","time spent":"374.143937ms","remote":"127.0.0.1:35764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1731,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T23:10:57.257552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.883306Z","time spent":"374.199048ms","remote":"127.0.0.1:35740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:10:57.257678Z","caller":"traceutil/trace.go:171","msg":"trace[892308645] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"371.878418ms","start":"2026-02-17T23:10:56.885793Z","end":"2026-02-17T23:10:57.257672Z","steps":["trace[892308645] 'process raft request' (duration: 371.493008ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.257701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.885788Z","time spent":"371.903158ms","remote":"127.0.0.1:54138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:10:57.257807Z","caller":"traceutil/trace.go:171","msg":"trace[947014648] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"371.797885ms","start":"2026-02-17T23:10:56.886005Z","end":"2026-02-17T23:10:57.257803Z","steps":["trace[947014648] 'process raft request' (duration: 371.306692ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.257964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.885987Z","time spent":"371.834187ms","remote":"127.0.0.1:54126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1247,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:10:57.258018Z","caller":"traceutil/trace.go:171","msg":"trace[1790895014] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"370.05281ms","start":"2026-02-17T23:10:56.887953Z","end":"2026-02-17T23:10:57.258006Z","steps":["trace[1790895014] 'process raft request' (duration: 369.384712ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:57.258032Z","caller":"traceutil/trace.go:171","msg":"trace[1089270656] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"364.444201ms","start":"2026-02-17T23:10:56.893583Z","end":"2026-02-17T23:10:57.258027Z","steps":["trace[1089270656] 'process raft request' (duration: 363.813865ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.25806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.887945Z","time spent":"370.09357ms","remote":"127.0.0.1:54070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T23:10:57.258066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.893575Z","time spent":"364.480383ms","remote":"127.0.0.1:54342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3620,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T23:10:57.258147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.991838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7237"} {"level":"info","ts":"2026-02-17T23:10:57.258161Z","caller":"traceutil/trace.go:171","msg":"trace[1354972412] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:326; }","duration":"370.018689ms","start":"2026-02-17T23:10:56.888137Z","end":"2026-02-17T23:10:57.258156Z","steps":["trace[1354972412] 'agreement among raft nodes before linearized reading' (duration: 369.987748ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.258174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.888133Z","time spent":"370.038329ms","remote":"127.0.0.1:54046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7261,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-02-17T23:10:57.258218Z","caller":"traceutil/trace.go:171","msg":"trace[279376458] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"370.105291ms","start":"2026-02-17T23:10:56.888106Z","end":"2026-02-17T23:10:57.258211Z","steps":["trace[279376458] 'process raft request' (duration: 369.253349ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.258302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.888101Z","time spent":"370.151412ms","remote":"127.0.0.1:54046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4715,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:10:57.258468Z","caller":"traceutil/trace.go:171","msg":"trace[1092074034] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"367.605895ms","start":"2026-02-17T23:10:56.890855Z","end":"2026-02-17T23:10:57.258461Z","steps":["trace[1092074034] 'process raft request' (duration: 366.524296ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.258505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.890849Z","time spent":"367.635305ms","remote":"127.0.0.1:54038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4102,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:10:57.265615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.008542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:10:57.265749Z","caller":"traceutil/trace.go:171","msg":"trace[1114388455] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"352.497837ms","start":"2026-02-17T23:10:56.913242Z","end":"2026-02-17T23:10:57.26574Z","steps":["trace[1114388455] 'process raft request' (duration: 352.22318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.265901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.913232Z","time spent":"352.582269ms","remote":"127.0.0.1:54046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3355,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:10:57.266152Z","caller":"traceutil/trace.go:171","msg":"trace[1491248054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:327; }","duration":"339.101904ms","start":"2026-02-17T23:10:56.926566Z","end":"2026-02-17T23:10:57.265667Z","steps":["trace[1491248054] 'agreement among raft nodes before linearized reading' (duration: 338.987031ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.26631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:56.926557Z","time spent":"339.67879ms","remote":"127.0.0.1:35668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T23:10:57.614018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.60073ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:10:57.614293Z","caller":"traceutil/trace.go:171","msg":"trace[503140471] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"335.458718ms","start":"2026-02-17T23:10:57.278799Z","end":"2026-02-17T23:10:57.614257Z","steps":["trace[503140471] 'process raft request' (duration: 194.55742ms)","trace[503140471] 'compare' (duration: 140.418856ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:10:57.614485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:57.278793Z","time spent":"335.616682ms","remote":"127.0.0.1:54070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:10:57.614673Z","caller":"traceutil/trace.go:171","msg":"trace[1925626631] linearizableReadLoop","detail":"{readStateIndex:343; appliedIndex:335; }","duration":"326.590045ms","start":"2026-02-17T23:10:57.288066Z","end":"2026-02-17T23:10:57.614656Z","steps":["trace[1925626631] 'read index received' (duration: 5.569926ms)","trace[1925626631] 'applied index is now lower than readState.Index' (duration: 321.019299ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:10:57.614888Z","caller":"traceutil/trace.go:171","msg":"trace[920870263] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"327.630943ms","start":"2026-02-17T23:10:57.287245Z","end":"2026-02-17T23:10:57.614875Z","steps":["trace[920870263] 'process raft request' (duration: 327.221722ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:57.614963Z","caller":"traceutil/trace.go:171","msg":"trace[255081211] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"324.573192ms","start":"2026-02-17T23:10:57.290372Z","end":"2026-02-17T23:10:57.614945Z","steps":["trace[255081211] 'process raft request' (duration: 324.164292ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.615056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:57.290364Z","time spent":"324.656444ms","remote":"127.0.0.1:35740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":654,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T23:10:57.615118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:57.287241Z","time spent":"327.721965ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:10:57.615258Z","caller":"traceutil/trace.go:171","msg":"trace[115012692] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"324.825008ms","start":"2026-02-17T23:10:57.290422Z","end":"2026-02-17T23:10:57.615247Z","steps":["trace[115012692] 'process raft request' (duration: 324.1434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.616913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:57.290418Z","time spent":"326.457891ms","remote":"127.0.0.1:35740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":669,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:10:57.615343Z","caller":"traceutil/trace.go:171","msg":"trace[644176202] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"324.84391ms","start":"2026-02-17T23:10:57.290491Z","end":"2026-02-17T23:10:57.615335Z","steps":["trace[644176202] 'process raft request' (duration: 324.09496ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.631225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:57.290486Z","time spent":"340.695657ms","remote":"127.0.0.1:35764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1731,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:10:57.615506Z","caller":"traceutil/trace.go:171","msg":"trace[1651539950] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"324.610673ms","start":"2026-02-17T23:10:57.290873Z","end":"2026-02-17T23:10:57.615484Z","steps":["trace[1651539950] 'process raft request' (duration: 323.74272ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.631364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:57.290867Z","time spent":"340.476221ms","remote":"127.0.0.1:54336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2864,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:10:57.615575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.50061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-17T23:10:57.631432Z","caller":"traceutil/trace.go:171","msg":"trace[1657620945] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:339; }","duration":"343.381837ms","start":"2026-02-17T23:10:57.288041Z","end":"2026-02-17T23:10:57.631423Z","steps":["trace[1657620945] 'agreement among raft nodes before linearized reading' (duration: 327.484369ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.631468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:57.288036Z","time spent":"343.426718ms","remote":"127.0.0.1:54070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-02-17T23:10:57.615663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.309473ms","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-17T23:10:57.63154Z","caller":"traceutil/trace.go:171","msg":"trace[1563941038] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:339; }","duration":"251.222842ms","start":"2026-02-17T23:10:57.380312Z","end":"2026-02-17T23:10:57.631535Z","steps":["trace[1563941038] 'agreement among raft nodes before linearized reading' (duration: 235.304703ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.615903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.089131ms","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-17T23:10:57.631622Z","caller":"traceutil/trace.go:171","msg":"trace[1438794697] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:339; }","duration":"189.850056ms","start":"2026-02-17T23:10:57.441768Z","end":"2026-02-17T23:10:57.631618Z","steps":["trace[1438794697] 'agreement among raft nodes before linearized reading' (duration: 174.067401ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:57.616291Z","caller":"traceutil/trace.go:171","msg":"trace[1767152135] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"333.229551ms","start":"2026-02-17T23:10:57.283049Z","end":"2026-02-17T23:10:57.616278Z","steps":["trace[1767152135] 'process raft request' (duration: 331.233698ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.631696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:57.283043Z","time spent":"348.638126ms","remote":"127.0.0.1:54046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3401,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:10:57.616325Z","caller":"traceutil/trace.go:171","msg":"trace[1856498302] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"337.477692ms","start":"2026-02-17T23:10:57.278842Z","end":"2026-02-17T23:10:57.61632Z","steps":["trace[1856498302] 'process raft request' (duration: 335.319115ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.631758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:57.278838Z","time spent":"352.907958ms","remote":"127.0.0.1:54046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7222,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:10:57.616406Z","caller":"traceutil/trace.go:171","msg":"trace[1793701848] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"334.936205ms","start":"2026-02-17T23:10:57.281464Z","end":"2026-02-17T23:10:57.6164Z","steps":["trace[1793701848] 'process raft request' (duration: 332.779098ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.631828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:57.281457Z","time spent":"350.35689ms","remote":"127.0.0.1:54126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2259,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:10:57.616425Z","caller":"traceutil/trace.go:171","msg":"trace[1718328057] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"330.007405ms","start":"2026-02-17T23:10:57.286413Z","end":"2026-02-17T23:10:57.616421Z","steps":["trace[1718328057] 'process raft request' (duration: 327.937781ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.631893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:57.286405Z","time spent":"345.476932ms","remote":"127.0.0.1:54326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3669,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:10:57.616604Z","caller":"traceutil/trace.go:171","msg":"trace[1014346028] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"329.43105ms","start":"2026-02-17T23:10:57.287165Z","end":"2026-02-17T23:10:57.616596Z","steps":["trace[1014346028] 'process raft request' (duration: 327.234452ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:57.63195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:10:57.28715Z","time spent":"344.788965ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:10:57.891191Z","caller":"traceutil/trace.go:171","msg":"trace[1725272258] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"213.303424ms","start":"2026-02-17T23:10:57.677865Z","end":"2026-02-17T23:10:57.891169Z","steps":["trace[1725272258] 'process raft request' (duration: 133.646748ms)","trace[1725272258] 'compare' (duration: 79.141733ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:10:57.944141Z","caller":"traceutil/trace.go:171","msg":"trace[1146724978] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"228.848073ms","start":"2026-02-17T23:10:57.715274Z","end":"2026-02-17T23:10:57.944122Z","steps":["trace[1146724978] 'process raft request' (duration: 228.681658ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:57.944921Z","caller":"traceutil/trace.go:171","msg":"trace[1171512669] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"229.537471ms","start":"2026-02-17T23:10:57.715353Z","end":"2026-02-17T23:10:57.94489Z","steps":["trace[1171512669] 'process raft request' (duration: 228.696819ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:57.945525Z","caller":"traceutil/trace.go:171","msg":"trace[2052592400] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"229.954192ms","start":"2026-02-17T23:10:57.715399Z","end":"2026-02-17T23:10:57.945353Z","steps":["trace[2052592400] 'process raft request' (duration: 228.675819ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:57.94575Z","caller":"traceutil/trace.go:171","msg":"trace[469448786] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"228.990467ms","start":"2026-02-17T23:10:57.716561Z","end":"2026-02-17T23:10:57.945551Z","steps":["trace[469448786] 'process raft request' (duration: 227.543359ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:57.945972Z","caller":"traceutil/trace.go:171","msg":"trace[987903907] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"226.102901ms","start":"2026-02-17T23:10:57.719845Z","end":"2026-02-17T23:10:57.945948Z","steps":["trace[987903907] 'process raft request' (duration: 224.283053ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:58.11129Z","caller":"traceutil/trace.go:171","msg":"trace[1231642838] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"149.767082ms","start":"2026-02-17T23:10:57.961501Z","end":"2026-02-17T23:10:58.111268Z","steps":["trace[1231642838] 'process raft request' (duration: 138.873545ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:58.112072Z","caller":"traceutil/trace.go:171","msg":"trace[348708184] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"136.209285ms","start":"2026-02-17T23:10:57.975847Z","end":"2026-02-17T23:10:58.112056Z","steps":["trace[348708184] 'process raft request' (duration: 136.159243ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:58.112794Z","caller":"traceutil/trace.go:171","msg":"trace[1754265089] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"145.395566ms","start":"2026-02-17T23:10:57.967382Z","end":"2026-02-17T23:10:58.112778Z","steps":["trace[1754265089] 'process raft request' (duration: 144.525374ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:58.112882Z","caller":"traceutil/trace.go:171","msg":"trace[301533581] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"145.077198ms","start":"2026-02-17T23:10:57.967784Z","end":"2026-02-17T23:10:58.112861Z","steps":["trace[301533581] 'process raft request' (duration: 144.157094ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:58.112924Z","caller":"traceutil/trace.go:171","msg":"trace[468211691] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"146.030283ms","start":"2026-02-17T23:10:57.966884Z","end":"2026-02-17T23:10:58.112914Z","steps":["trace[468211691] 'process raft request' (duration: 144.955255ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:10:58.378046Z","caller":"traceutil/trace.go:171","msg":"trace[1906459768] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"169.097217ms","start":"2026-02-17T23:10:58.208931Z","end":"2026-02-17T23:10:58.378028Z","steps":["trace[1906459768] 'process raft request' (duration: 77.395757ms)","trace[1906459768] 'compare' (duration: 91.545896ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:10:59.587217Z","caller":"traceutil/trace.go:171","msg":"trace[1400247996] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"279.05243ms","start":"2026-02-17T23:10:59.308146Z","end":"2026-02-17T23:10:59.587198Z","steps":["trace[1400247996] 'process raft request' (duration: 278.923326ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:10:59.943313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.666057ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:10:59.943726Z","caller":"traceutil/trace.go:171","msg":"trace[1052618050] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"176.472483ms","start":"2026-02-17T23:10:59.767233Z","end":"2026-02-17T23:10:59.943705Z","steps":["trace[1052618050] 'process raft request' (duration: 49.345443ms)","trace[1052618050] 'compare' (duration: 126.561275ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:11:00.408715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.48966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"} {"level":"info","ts":"2026-02-17T23:11:00.408774Z","caller":"traceutil/trace.go:171","msg":"trace[2090104343] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:362; }","duration":"153.586813ms","start":"2026-02-17T23:11:00.255174Z","end":"2026-02-17T23:11:00.40876Z","steps":["trace[2090104343] 'range keys from in-memory index tree' (duration: 153.408248ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:00.563855Z","caller":"traceutil/trace.go:171","msg":"trace[330255773] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"149.892646ms","start":"2026-02-17T23:11:00.413942Z","end":"2026-02-17T23:11:00.563835Z","steps":["trace[330255773] 'process raft request' (duration: 149.790204ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:00.812443Z","caller":"traceutil/trace.go:171","msg":"trace[1202818521] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"120.713552ms","start":"2026-02-17T23:11:00.691711Z","end":"2026-02-17T23:11:00.812424Z","steps":["trace[1202818521] 'process raft request' (duration: 116.423249ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:00.813477Z","caller":"traceutil/trace.go:171","msg":"trace[2137134388] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:376; }","duration":"121.41294ms","start":"2026-02-17T23:11:00.692052Z","end":"2026-02-17T23:11:00.813465Z","steps":["trace[2137134388] 'read index received' (duration: 116.088741ms)","trace[2137134388] 'applied index is now lower than readState.Index' (duration: 5.322619ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:11:00.81356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.491952ms","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-17T23:11:00.813584Z","caller":"traceutil/trace.go:171","msg":"trace[54127472] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:368; }","duration":"121.543884ms","start":"2026-02-17T23:11:00.692033Z","end":"2026-02-17T23:11:00.813577Z","steps":["trace[54127472] 'agreement among raft nodes before linearized reading' (duration: 121.471492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:01.032736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.480907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:11:01.032808Z","caller":"traceutil/trace.go:171","msg":"trace[527175819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:369; }","duration":"104.59684ms","start":"2026-02-17T23:11:00.928195Z","end":"2026-02-17T23:11:01.032792Z","steps":["trace[527175819] 'range keys from in-memory index tree' (duration: 104.425255ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:01.429336Z","caller":"traceutil/trace.go:171","msg":"trace[1337150803] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"130.530639ms","start":"2026-02-17T23:11:01.298782Z","end":"2026-02-17T23:11:01.429313Z","steps":["trace[1337150803] 'process raft request' (duration: 130.390765ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:01.638011Z","caller":"traceutil/trace.go:171","msg":"trace[2047747479] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"196.2174ms","start":"2026-02-17T23:11:01.44177Z","end":"2026-02-17T23:11:01.637987Z","steps":["trace[2047747479] 'process raft request' (duration: 158.642296ms)","trace[2047747479] 'compare' (duration: 37.464201ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:11:06.114631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.985986ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-17T23:11:06.114721Z","caller":"traceutil/trace.go:171","msg":"trace[1233729453] linearizableReadLoop","detail":"{readStateIndex:395; appliedIndex:394; }","duration":"373.158285ms","start":"2026-02-17T23:11:05.741544Z","end":"2026-02-17T23:11:06.114702Z","steps":["trace[1233729453] 'read index received' (duration: 27.071µs)","trace[1233729453] 'applied index is now lower than readState.Index' (duration: 373.129654ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:11:06.114855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.301008ms","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-17T23:11:06.114881Z","caller":"traceutil/trace.go:171","msg":"trace[1613473793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:384; }","duration":"373.363969ms","start":"2026-02-17T23:11:05.741507Z","end":"2026-02-17T23:11:06.114871Z","steps":["trace[1613473793] 'agreement among raft nodes before linearized reading' (duration: 373.294697ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:06.114905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.409215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-17T23:11:06.114915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:05.741491Z","time spent":"373.416001ms","remote":"127.0.0.1:54132","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-17T23:11:06.114996Z","caller":"traceutil/trace.go:171","msg":"trace[1004187466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:384; }","duration":"372.463816ms","start":"2026-02-17T23:11:05.742465Z","end":"2026-02-17T23:11:06.114929Z","steps":["trace[1004187466] 'agreement among raft nodes before linearized reading' (duration: 372.401194ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:06.115019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:05.742458Z","time spent":"372.555849ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T23:11:06.115106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.616855ms","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-17T23:11:06.115129Z","caller":"traceutil/trace.go:171","msg":"trace[415457922] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:384; }","duration":"150.660986ms","start":"2026-02-17T23:11:05.964461Z","end":"2026-02-17T23:11:06.115122Z","steps":["trace[415457922] 'agreement among raft nodes before linearized reading' (duration: 150.618715ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:06.115241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.803152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-02-17T23:11:06.115274Z","caller":"traceutil/trace.go:171","msg":"trace[144360724] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:384; }","duration":"286.886274ms","start":"2026-02-17T23:11:05.828379Z","end":"2026-02-17T23:11:06.115266Z","steps":["trace[144360724] 'agreement among raft nodes before linearized reading' (duration: 286.813293ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:06.115327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.654264ms","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-17T23:11:06.115353Z","caller":"traceutil/trace.go:171","msg":"trace[745550036] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:384; }","duration":"337.709136ms","start":"2026-02-17T23:11:05.777637Z","end":"2026-02-17T23:11:06.115346Z","steps":["trace[745550036] 'agreement among raft nodes before linearized reading' (duration: 337.653774ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:06.115372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:05.777626Z","time spent":"337.741406ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T23:11:06.11541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.504909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:11:06.11548Z","caller":"traceutil/trace.go:171","msg":"trace[1853294001] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:384; }","duration":"185.55609ms","start":"2026-02-17T23:11:05.929871Z","end":"2026-02-17T23:11:06.115427Z","steps":["trace[1853294001] 'agreement among raft nodes before linearized reading' (duration: 185.519349ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:06.7657Z","caller":"traceutil/trace.go:171","msg":"trace[1096073953] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"641.617517ms","start":"2026-02-17T23:11:06.124065Z","end":"2026-02-17T23:11:06.765682Z","steps":["trace[1096073953] 'process raft request' (duration: 641.508664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:06.765807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:06.124046Z","time spent":"641.704348ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:11:06.93733Z","caller":"traceutil/trace.go:171","msg":"trace[1440841129] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"805.987152ms","start":"2026-02-17T23:11:06.13132Z","end":"2026-02-17T23:11:06.937307Z","steps":["trace[1440841129] 'process raft request' (duration: 805.938511ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:06.937503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:06.13131Z","time spent":"806.085785ms","remote":"127.0.0.1:54326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:11:06.938032Z","caller":"traceutil/trace.go:171","msg":"trace[646383358] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"813.829237ms","start":"2026-02-17T23:11:06.12419Z","end":"2026-02-17T23:11:06.938019Z","steps":["trace[646383358] 'process raft request' (duration: 809.769511ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:06.938113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:06.124182Z","time spent":"813.894529ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:11:06.938904Z","caller":"traceutil/trace.go:171","msg":"trace[1581593218] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"811.281831ms","start":"2026-02-17T23:11:06.127608Z","end":"2026-02-17T23:11:06.93889Z","steps":["trace[1581593218] 'process raft request' (duration: 809.623527ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:06.938975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:06.127603Z","time spent":"811.332932ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:11:06.938273Z","caller":"traceutil/trace.go:171","msg":"trace[1748549118] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"810.727246ms","start":"2026-02-17T23:11:06.127537Z","end":"2026-02-17T23:11:06.938264Z","steps":["trace[1748549118] 'process raft request' (duration: 809.655958ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:06.939695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:06.127523Z","time spent":"812.137643ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:11:09.3058Z","caller":"traceutil/trace.go:171","msg":"trace[785983646] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"268.750109ms","start":"2026-02-17T23:11:09.03703Z","end":"2026-02-17T23:11:09.30578Z","steps":["trace[785983646] 'process raft request' (duration: 205.00941ms)","trace[785983646] 'compare' (duration: 63.421371ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:11:09.305799Z","caller":"traceutil/trace.go:171","msg":"trace[1993498982] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"268.655197ms","start":"2026-02-17T23:11:09.037124Z","end":"2026-02-17T23:11:09.305779Z","steps":["trace[1993498982] 'process raft request' (duration: 268.529764ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:20.695161Z","caller":"traceutil/trace.go:171","msg":"trace[2024558246] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"713.381136ms","start":"2026-02-17T23:11:19.981759Z","end":"2026-02-17T23:11:20.69514Z","steps":["trace[2024558246] 'process raft request' (duration: 713.234042ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:20.695569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:19.981742Z","time spent":"713.772796ms","remote":"127.0.0.1:54038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4254,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:11:20.701041Z","caller":"traceutil/trace.go:171","msg":"trace[278168293] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:494; }","duration":"151.077867ms","start":"2026-02-17T23:11:20.549943Z","end":"2026-02-17T23:11:20.701021Z","steps":["trace[278168293] 'read index received' (duration: 145.253634ms)","trace[278168293] 'applied index is now lower than readState.Index' (duration: 5.823473ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:11:20.701308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.344125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.195\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-17T23:11:20.701379Z","caller":"traceutil/trace.go:171","msg":"trace[419012892] range","detail":"{range_begin:/registry/masterleases/162.253.55.195; range_end:; response_count:1; response_revision:481; }","duration":"151.455187ms","start":"2026-02-17T23:11:20.549913Z","end":"2026-02-17T23:11:20.701369Z","steps":["trace[419012892] 'agreement among raft nodes before linearized reading' (duration: 151.230441ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:20.701702Z","caller":"traceutil/trace.go:171","msg":"trace[1802762043] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"502.026159ms","start":"2026-02-17T23:11:20.199666Z","end":"2026-02-17T23:11:20.701692Z","steps":["trace[1802762043] 'process raft request' (duration: 501.124676ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:20.701803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:20.199649Z","time spent":"502.07768ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:11:23.038568Z","caller":"traceutil/trace.go:171","msg":"trace[1254288993] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:501; }","duration":"212.752393ms","start":"2026-02-17T23:11:22.825798Z","end":"2026-02-17T23:11:23.038551Z","steps":["trace[1254288993] 'read index received' (duration: 212.603009ms)","trace[1254288993] 'applied index is now lower than readState.Index' (duration: 148.904µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:11:23.038712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.895646ms","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-17T23:11:23.038728Z","caller":"traceutil/trace.go:171","msg":"trace[1295597902] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:487; }","duration":"212.956008ms","start":"2026-02-17T23:11:22.825767Z","end":"2026-02-17T23:11:23.038723Z","steps":["trace[1295597902] 'agreement among raft nodes before linearized reading' (duration: 212.850085ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:23.038805Z","caller":"traceutil/trace.go:171","msg":"trace[1060248138] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"219.375576ms","start":"2026-02-17T23:11:22.819425Z","end":"2026-02-17T23:11:23.0388Z","steps":["trace[1060248138] 'process raft request' (duration: 219.035267ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:23.433604Z","caller":"traceutil/trace.go:171","msg":"trace[973449239] linearizableReadLoop","detail":"{readStateIndex:503; appliedIndex:502; }","duration":"333.271809ms","start":"2026-02-17T23:11:23.100316Z","end":"2026-02-17T23:11:23.433588Z","steps":["trace[973449239] 'read index received' (duration: 285.551779ms)","trace[973449239] 'applied index is now lower than readState.Index' (duration: 47.71927ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:11:23.433802Z","caller":"traceutil/trace.go:171","msg":"trace[1684953381] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"392.163353ms","start":"2026-02-17T23:11:23.041631Z","end":"2026-02-17T23:11:23.433794Z","steps":["trace[1684953381] 'process raft request' (duration: 344.296209ms)","trace[1684953381] 'compare' (duration: 47.555446ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:11:23.433881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:23.04161Z","time spent":"392.209203ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:11:23.434075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.745373ms","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-17T23:11:23.434095Z","caller":"traceutil/trace.go:171","msg":"trace[337148463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:488; }","duration":"333.810233ms","start":"2026-02-17T23:11:23.100279Z","end":"2026-02-17T23:11:23.434089Z","steps":["trace[337148463] 'agreement among raft nodes before linearized reading' (duration: 333.723871ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:23.434111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:23.100259Z","time spent":"333.848605ms","remote":"127.0.0.1:54132","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-17T23:11:23.936355Z","caller":"traceutil/trace.go:171","msg":"trace[2119589004] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"498.349103ms","start":"2026-02-17T23:11:23.437978Z","end":"2026-02-17T23:11:23.936327Z","steps":["trace[2119589004] 'process raft request' (duration: 437.549241ms)","trace[2119589004] 'compare' (duration: 60.690919ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:11:23.93645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:23.437962Z","time spent":"498.432485ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:11:23.987861Z","caller":"traceutil/trace.go:171","msg":"trace[657422975] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"548.152238ms","start":"2026-02-17T23:11:23.439687Z","end":"2026-02-17T23:11:23.987839Z","steps":["trace[657422975] 'process raft request' (duration: 547.591213ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:23.987985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:23.439671Z","time spent":"548.24887ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:11:23.988044Z","caller":"traceutil/trace.go:171","msg":"trace[190778582] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"549.230776ms","start":"2026-02-17T23:11:23.438797Z","end":"2026-02-17T23:11:23.988028Z","steps":["trace[190778582] 'process raft request' (duration: 548.380923ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:23.988145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:23.438792Z","time spent":"549.306018ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:11:25.552156Z","caller":"traceutil/trace.go:171","msg":"trace[1862609383] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"111.47113ms","start":"2026-02-17T23:11:25.440669Z","end":"2026-02-17T23:11:25.55214Z","steps":["trace[1862609383] 'process raft request' (duration: 111.393498ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:28.542966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.952768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:11:28.543059Z","caller":"traceutil/trace.go:171","msg":"trace[1606285285] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:499; }","duration":"615.081292ms","start":"2026-02-17T23:11:27.927957Z","end":"2026-02-17T23:11:28.543038Z","steps":["trace[1606285285] 'range keys from in-memory index tree' (duration: 614.873896ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:28.543112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:27.927943Z","time spent":"615.158364ms","remote":"127.0.0.1:35668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T23:11:28.543466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.731694ms","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-17T23:11:28.543488Z","caller":"traceutil/trace.go:171","msg":"trace[1413129655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:499; }","duration":"595.816916ms","start":"2026-02-17T23:11:27.947664Z","end":"2026-02-17T23:11:28.543481Z","steps":["trace[1413129655] 'range keys from in-memory index tree' (duration: 595.551579ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:28.543507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:27.947654Z","time spent":"595.848388ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T23:11:28.544048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.313549ms","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-17T23:11:28.544085Z","caller":"traceutil/trace.go:171","msg":"trace[27688832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:499; }","duration":"541.401241ms","start":"2026-02-17T23:11:28.002676Z","end":"2026-02-17T23:11:28.544077Z","steps":["trace[27688832] 'range keys from in-memory index tree' (duration: 541.237757ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:28.544104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:28.002666Z","time spent":"541.432903ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T23:11:28.54422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.097411ms","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-17T23:11:28.544237Z","caller":"traceutil/trace.go:171","msg":"trace[1312265968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:499; }","duration":"539.156093ms","start":"2026-02-17T23:11:28.005076Z","end":"2026-02-17T23:11:28.544232Z","steps":["trace[1312265968] 'range keys from in-memory index tree' (duration: 539.028819ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:28.544257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:28.005065Z","time spent":"539.188764ms","remote":"127.0.0.1:54132","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":"warn","ts":"2026-02-17T23:11:28.54445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.728855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sbpsq\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-17T23:11:28.544469Z","caller":"traceutil/trace.go:171","msg":"trace[874682009] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sbpsq; range_end:; response_count:1; response_revision:499; }","duration":"122.782816ms","start":"2026-02-17T23:11:28.42168Z","end":"2026-02-17T23:11:28.544463Z","steps":["trace[874682009] 'range keys from in-memory index tree' (duration: 122.633213ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:29.209128Z","caller":"traceutil/trace.go:171","msg":"trace[1816192578] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"657.989375ms","start":"2026-02-17T23:11:28.551115Z","end":"2026-02-17T23:11:29.209105Z","steps":["trace[1816192578] 'process raft request' (duration: 657.81568ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:29.209282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:28.551098Z","time spent":"658.096807ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:11:29.647968Z","caller":"traceutil/trace.go:171","msg":"trace[1332173426] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"1.085941663s","start":"2026-02-17T23:11:28.562002Z","end":"2026-02-17T23:11:29.647944Z","steps":["trace[1332173426] 'process raft request' (duration: 1.085790789s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:29.648115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:28.561983Z","time spent":"1.086053277s","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:11:29.648429Z","caller":"traceutil/trace.go:171","msg":"trace[2025739415] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:516; }","duration":"719.129867ms","start":"2026-02-17T23:11:28.929287Z","end":"2026-02-17T23:11:29.648417Z","steps":["trace[2025739415] 'read index received' (duration: 280.415875ms)","trace[2025739415] 'applied index is now lower than readState.Index' (duration: 438.713012ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:11:29.648396Z","caller":"traceutil/trace.go:171","msg":"trace[336212196] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"1.086287803s","start":"2026-02-17T23:11:28.562086Z","end":"2026-02-17T23:11:29.648373Z","steps":["trace[336212196] 'process raft request' (duration: 1.08582098s)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:29.648598Z","caller":"traceutil/trace.go:171","msg":"trace[1052337681] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"1.085687387s","start":"2026-02-17T23:11:28.562901Z","end":"2026-02-17T23:11:29.648588Z","steps":["trace[1052337681] 'process raft request' (duration: 1.085260506s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:29.64865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:28.562066Z","time spent":"1.086506709s","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:11:29.648659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:28.562894Z","time spent":"1.085730308s","remote":"127.0.0.1:54046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:11:29.648824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.534337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:11:29.648856Z","caller":"traceutil/trace.go:171","msg":"trace[328029282] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:503; }","duration":"719.594889ms","start":"2026-02-17T23:11:28.929251Z","end":"2026-02-17T23:11:29.648846Z","steps":["trace[328029282] 'agreement among raft nodes before linearized reading' (duration: 719.546058ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:29.648888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:28.929232Z","time spent":"719.65022ms","remote":"127.0.0.1:35658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T23:11:30.546024Z","caller":"traceutil/trace.go:171","msg":"trace[1409659023] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"106.715466ms","start":"2026-02-17T23:11:30.439281Z","end":"2026-02-17T23:11:30.545996Z","steps":["trace[1409659023] 'process raft request' (duration: 106.338686ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:32.0318Z","caller":"traceutil/trace.go:171","msg":"trace[1575845887] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"369.230142ms","start":"2026-02-17T23:11:31.662548Z","end":"2026-02-17T23:11:32.031778Z","steps":["trace[1575845887] 'read index received' (duration: 369.052437ms)","trace[1575845887] 'applied index is now lower than readState.Index' (duration: 176.905µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:11:32.031922Z","caller":"traceutil/trace.go:171","msg":"trace[453345180] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"415.74979ms","start":"2026-02-17T23:11:31.616161Z","end":"2026-02-17T23:11:32.031911Z","steps":["trace[453345180] 'process raft request' (duration: 415.498454ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:32.032003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:31.616154Z","time spent":"415.794351ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T23:11:32.032252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.689774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-17T23:11:32.03231Z","caller":"traceutil/trace.go:171","msg":"trace[1206942163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:521; }","duration":"369.793626ms","start":"2026-02-17T23:11:31.662506Z","end":"2026-02-17T23:11:32.032299Z","steps":["trace[1206942163] 'agreement among raft nodes before linearized reading' (duration: 369.618752ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:32.032338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:31.662491Z","time spent":"369.840637ms","remote":"127.0.0.1:54132","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-17T23:11:32.03255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.876119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-17T23:11:32.03258Z","caller":"traceutil/trace.go:171","msg":"trace[593016501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:521; }","duration":"369.988002ms","start":"2026-02-17T23:11:31.662583Z","end":"2026-02-17T23:11:32.032571Z","steps":["trace[593016501] 'agreement among raft nodes before linearized reading' (duration: 369.843318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:32.032608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:31.662578Z","time spent":"370.023092ms","remote":"127.0.0.1:54132","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-17T23:11:32.032818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.374202ms","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-17T23:11:32.032843Z","caller":"traceutil/trace.go:171","msg":"trace[372500681] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:521; }","duration":"362.412444ms","start":"2026-02-17T23:11:31.670423Z","end":"2026-02-17T23:11:32.032835Z","steps":["trace[372500681] 'agreement among raft nodes before linearized reading' (duration: 362.339882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:32.032873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:31.670416Z","time spent":"362.450974ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-17T23:11:34.809592Z","caller":"traceutil/trace.go:171","msg":"trace[396899269] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"136.546766ms","start":"2026-02-17T23:11:34.673022Z","end":"2026-02-17T23:11:34.809569Z","steps":["trace[396899269] 'read index received' (duration: 113.073741ms)","trace[396899269] 'applied index is now lower than readState.Index' (duration: 23.472085ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:11:34.810789Z","caller":"traceutil/trace.go:171","msg":"trace[1816246146] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"169.419578ms","start":"2026-02-17T23:11:34.641323Z","end":"2026-02-17T23:11:34.810743Z","steps":["trace[1816246146] 'process raft request' (duration: 144.838974ms)","trace[1816246146] 'compare' (duration: 23.28619ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:11:34.811297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.248561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-02-17T23:11:34.811351Z","caller":"traceutil/trace.go:171","msg":"trace[340975352] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:579; }","duration":"138.411875ms","start":"2026-02-17T23:11:34.672913Z","end":"2026-02-17T23:11:34.811325Z","steps":["trace[340975352] 'agreement among raft nodes before linearized reading' (duration: 136.743031ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:42.210333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.454288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:11:42.210433Z","caller":"traceutil/trace.go:171","msg":"trace[143137817] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"874.709871ms","start":"2026-02-17T23:11:41.335709Z","end":"2026-02-17T23:11:42.210418Z","steps":["trace[143137817] 'process raft request' (duration: 618.12277ms)","trace[143137817] 'compare' (duration: 256.178041ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:11:42.210471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:41.335693Z","time spent":"874.763442ms","remote":"127.0.0.1:35740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:11:42.578799Z","caller":"traceutil/trace.go:171","msg":"trace[115941203] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"652.412389ms","start":"2026-02-17T23:11:41.926366Z","end":"2026-02-17T23:11:42.578778Z","steps":["trace[115941203] 'read index received' (duration: 27.48156ms)","trace[115941203] 'applied index is now lower than readState.Index' (duration: 624.929799ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:11:42.579061Z","caller":"traceutil/trace.go:171","msg":"trace[2123655976] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.223445406s","start":"2026-02-17T23:11:41.355602Z","end":"2026-02-17T23:11:42.579048Z","steps":["trace[2123655976] 'process raft request' (duration: 1.144920119s)","trace[2123655976] 'compare' (duration: 78.171048ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:11:42.579153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:41.355584Z","time spent":"1.223507728s","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:11:42.579321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.964173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:11:42.57935Z","caller":"traceutil/trace.go:171","msg":"trace[2097091729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"653.022415ms","start":"2026-02-17T23:11:41.926319Z","end":"2026-02-17T23:11:42.579341Z","steps":["trace[2097091729] 'agreement among raft nodes before linearized reading' (duration: 652.977874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:42.579375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:41.926305Z","time spent":"653.064427ms","remote":"127.0.0.1:35668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T23:11:42.579646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.056233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-17T23:11:42.579675Z","caller":"traceutil/trace.go:171","msg":"trace[1723122705] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:637; }","duration":"420.143524ms","start":"2026-02-17T23:11:42.159523Z","end":"2026-02-17T23:11:42.579666Z","steps":["trace[1723122705] 'agreement among raft nodes before linearized reading' (duration: 420.033252ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:42.579701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:42.1595Z","time spent":"420.195216ms","remote":"127.0.0.1:54132","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-17T23:11:42.579926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.020369ms","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-17T23:11:42.579961Z","caller":"traceutil/trace.go:171","msg":"trace[1430347117] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:637; }","duration":"405.06759ms","start":"2026-02-17T23:11:42.174886Z","end":"2026-02-17T23:11:42.579953Z","steps":["trace[1430347117] 'agreement among raft nodes before linearized reading' (duration: 404.985678ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:42.579986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:42.174879Z","time spent":"405.100632ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-17T23:11:42.580146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.840468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-17T23:11:42.580172Z","caller":"traceutil/trace.go:171","msg":"trace[1545403757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"411.878528ms","start":"2026-02-17T23:11:42.168286Z","end":"2026-02-17T23:11:42.580165Z","steps":["trace[1545403757] 'agreement among raft nodes before linearized reading' (duration: 411.793636ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:42.580196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:42.168279Z","time spent":"411.911169ms","remote":"127.0.0.1:54132","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-17T23:11:42.580357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.406997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T23:11:42.580382Z","caller":"traceutil/trace.go:171","msg":"trace[2143884640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"416.459509ms","start":"2026-02-17T23:11:42.163914Z","end":"2026-02-17T23:11:42.580374Z","steps":["trace[2143884640] 'agreement among raft nodes before linearized reading' (duration: 416.391367ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:42.580405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:42.163897Z","time spent":"416.50337ms","remote":"127.0.0.1:54132","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":"info","ts":"2026-02-17T23:11:49.542744Z","caller":"traceutil/trace.go:171","msg":"trace[1443537789] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"264.9644ms","start":"2026-02-17T23:11:49.277754Z","end":"2026-02-17T23:11:49.542719Z","steps":["trace[1443537789] 'process raft request' (duration: 264.833616ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:50.608711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.832917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:11:50.608775Z","caller":"traceutil/trace.go:171","msg":"trace[1785885617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:693; }","duration":"679.934559ms","start":"2026-02-17T23:11:49.928825Z","end":"2026-02-17T23:11:50.60876Z","steps":["trace[1785885617] 'range keys from in-memory index tree' (duration: 679.778345ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:50.60883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:49.92881Z","time spent":"680.009411ms","remote":"127.0.0.1:35658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T23:11:50.756882Z","caller":"traceutil/trace.go:171","msg":"trace[492276567] linearizableReadLoop","detail":"{readStateIndex:716; appliedIndex:715; }","duration":"126.150914ms","start":"2026-02-17T23:11:50.630715Z","end":"2026-02-17T23:11:50.756866Z","steps":["trace[492276567] 'read index received' (duration: 126.00027ms)","trace[492276567] 'applied index is now lower than readState.Index' (duration: 149.874µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:11:50.757036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.302048ms","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-17T23:11:50.757053Z","caller":"traceutil/trace.go:171","msg":"trace[1113316687] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:693; }","duration":"126.34938ms","start":"2026-02-17T23:11:50.630698Z","end":"2026-02-17T23:11:50.757047Z","steps":["trace[1113316687] 'agreement among raft nodes before linearized reading' (duration: 126.245657ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:50.75722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.83406ms","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-17T23:11:50.757268Z","caller":"traceutil/trace.go:171","msg":"trace[1313551859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:693; }","duration":"116.907342ms","start":"2026-02-17T23:11:50.640347Z","end":"2026-02-17T23:11:50.757254Z","steps":["trace[1313551859] 'agreement among raft nodes before linearized reading' (duration: 116.777509ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:50.757294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.890795ms","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-17T23:11:50.757314Z","caller":"traceutil/trace.go:171","msg":"trace[2030680828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:693; }","duration":"115.931457ms","start":"2026-02-17T23:11:50.641378Z","end":"2026-02-17T23:11:50.757309Z","steps":["trace[2030680828] 'agreement among raft nodes before linearized reading' (duration: 115.884296ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:50.757379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.971914ms","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-17T23:11:50.757398Z","caller":"traceutil/trace.go:171","msg":"trace[980790630] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:693; }","duration":"117.017435ms","start":"2026-02-17T23:11:50.640374Z","end":"2026-02-17T23:11:50.757391Z","steps":["trace[980790630] 'agreement among raft nodes before linearized reading' (duration: 116.974804ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:50.963727Z","caller":"traceutil/trace.go:171","msg":"trace[1738543176] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"205.38408ms","start":"2026-02-17T23:11:50.758321Z","end":"2026-02-17T23:11:50.963705Z","steps":["trace[1738543176] 'process raft request' (duration: 203.563872ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:50.970901Z","caller":"traceutil/trace.go:171","msg":"trace[183685833] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"209.153939ms","start":"2026-02-17T23:11:50.761728Z","end":"2026-02-17T23:11:50.970882Z","steps":["trace[183685833] 'process raft request' (duration: 209.069127ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:50.971096Z","caller":"traceutil/trace.go:171","msg":"trace[370707905] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"209.313872ms","start":"2026-02-17T23:11:50.761774Z","end":"2026-02-17T23:11:50.971087Z","steps":["trace[370707905] 'process raft request' (duration: 209.046935ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:50.971173Z","caller":"traceutil/trace.go:171","msg":"trace[51475561] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"209.485087ms","start":"2026-02-17T23:11:50.761676Z","end":"2026-02-17T23:11:50.971161Z","steps":["trace[51475561] 'process raft request' (duration: 209.017595ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:11:50.971625Z","caller":"traceutil/trace.go:171","msg":"trace[923321710] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"209.790205ms","start":"2026-02-17T23:11:50.761819Z","end":"2026-02-17T23:11:50.971609Z","steps":["trace[923321710] 'process raft request' (duration: 209.22543ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:52.211008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.733574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:11:52.211064Z","caller":"traceutil/trace.go:171","msg":"trace[223117838] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:699; }","duration":"435.829707ms","start":"2026-02-17T23:11:51.775223Z","end":"2026-02-17T23:11:52.211052Z","steps":["trace[223117838] 'count revisions from in-memory index tree' (duration: 435.683843ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:11:52.211099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:11:51.775204Z","time spent":"435.889178ms","remote":"127.0.0.1:54120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-02-17T23:11:52.211223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.995545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:11:52.21124Z","caller":"traceutil/trace.go:171","msg":"trace[1572533572] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:699; }","duration":"285.038947ms","start":"2026-02-17T23:11:51.926196Z","end":"2026-02-17T23:11:52.211235Z","steps":["trace[1572533572] 'range keys from in-memory index tree' (duration: 284.938693ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:07.164822Z","caller":"traceutil/trace.go:171","msg":"trace[2114685868] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"114.488199ms","start":"2026-02-17T23:12:07.050317Z","end":"2026-02-17T23:12:07.164805Z","steps":["trace[2114685868] 'process raft request' (duration: 114.374806ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:07.173782Z","caller":"traceutil/trace.go:171","msg":"trace[728649232] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"120.251991ms","start":"2026-02-17T23:12:07.05352Z","end":"2026-02-17T23:12:07.173772Z","steps":["trace[728649232] 'process raft request' (duration: 120.2277ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:07.173948Z","caller":"traceutil/trace.go:171","msg":"trace[312242308] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"123.545098ms","start":"2026-02-17T23:12:07.050397Z","end":"2026-02-17T23:12:07.173942Z","steps":["trace[312242308] 'process raft request' (duration: 123.25279ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:07.174304Z","caller":"traceutil/trace.go:171","msg":"trace[2018950901] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"120.806155ms","start":"2026-02-17T23:12:07.053487Z","end":"2026-02-17T23:12:07.174294Z","steps":["trace[2018950901] 'process raft request' (duration: 120.22706ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:10.083516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.660228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:12:10.08359Z","caller":"traceutil/trace.go:171","msg":"trace[1710967248] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:755; }","duration":"152.74099ms","start":"2026-02-17T23:12:09.93083Z","end":"2026-02-17T23:12:10.083571Z","steps":["trace[1710967248] 'range keys from in-memory index tree' (duration: 152.584215ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:11.077849Z","caller":"traceutil/trace.go:171","msg":"trace[1871405370] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"405.867275ms","start":"2026-02-17T23:12:10.671956Z","end":"2026-02-17T23:12:11.077823Z","steps":["trace[1871405370] 'process raft request' (duration: 351.471986ms)","trace[1871405370] 'compare' (duration: 53.992508ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:12:11.077988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:10.671932Z","time spent":"405.982018ms","remote":"127.0.0.1:35684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:12:11.832256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.194613ms","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-17T23:12:11.832329Z","caller":"traceutil/trace.go:171","msg":"trace[1785173122] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:756; }","duration":"158.328467ms","start":"2026-02-17T23:12:11.673983Z","end":"2026-02-17T23:12:11.832311Z","steps":["trace[1785173122] 'range keys from in-memory index tree' (duration: 157.904136ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:11.832477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.167403ms","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":"warn","ts":"2026-02-17T23:12:11.832555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.431775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T23:12:11.832556Z","caller":"traceutil/trace.go:171","msg":"trace[378415468] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:756; }","duration":"645.260076ms","start":"2026-02-17T23:12:11.187278Z","end":"2026-02-17T23:12:11.832538Z","steps":["trace[378415468] 'range keys from in-memory index tree' (duration: 645.03958ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:11.832588Z","caller":"traceutil/trace.go:171","msg":"trace[1877494286] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:756; }","duration":"576.507977ms","start":"2026-02-17T23:12:11.256069Z","end":"2026-02-17T23:12:11.832577Z","steps":["trace[1877494286] 'count revisions from in-memory index tree' (duration: 576.343253ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:11.8326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:11.187234Z","time spent":"645.354778ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-17T23:12:11.83262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:11.256048Z","time spent":"576.561058ms","remote":"127.0.0.1:54126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":31,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-02-17T23:12:11.832806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.156417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-17T23:12:11.832834Z","caller":"traceutil/trace.go:171","msg":"trace[1712268459] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:756; }","duration":"641.196178ms","start":"2026-02-17T23:12:11.191629Z","end":"2026-02-17T23:12:11.832825Z","steps":["trace[1712268459] 'range keys from in-memory index tree' (duration: 641.093675ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:11.832861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:11.191623Z","time spent":"641.232539ms","remote":"127.0.0.1:54132","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-17T23:12:11.83303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.719009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-17T23:12:11.833056Z","caller":"traceutil/trace.go:171","msg":"trace[854799686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:756; }","duration":"639.75784ms","start":"2026-02-17T23:12:11.193291Z","end":"2026-02-17T23:12:11.833049Z","steps":["trace[854799686] 'range keys from in-memory index tree' (duration: 639.646827ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:11.83308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:11.193285Z","time spent":"639.789721ms","remote":"127.0.0.1:54132","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-17T23:12:11.833221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.083103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T23:12:11.833245Z","caller":"traceutil/trace.go:171","msg":"trace[864691460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:756; }","duration":"639.116523ms","start":"2026-02-17T23:12:11.19412Z","end":"2026-02-17T23:12:11.833237Z","steps":["trace[864691460] 'range keys from in-memory index tree' (duration: 639.028461ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:11.833268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:11.194114Z","time spent":"639.148354ms","remote":"127.0.0.1:54132","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":"info","ts":"2026-02-17T23:12:12.136955Z","caller":"traceutil/trace.go:171","msg":"trace[1427465731] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"297.408797ms","start":"2026-02-17T23:12:11.839524Z","end":"2026-02-17T23:12:12.136933Z","steps":["trace[1427465731] 'process raft request' (duration: 297.273413ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:12.3112Z","caller":"traceutil/trace.go:171","msg":"trace[692148786] linearizableReadLoop","detail":"{readStateIndex:789; appliedIndex:785; }","duration":"382.323282ms","start":"2026-02-17T23:12:11.928856Z","end":"2026-02-17T23:12:12.31118Z","steps":["trace[692148786] 'read index received' (duration: 208.7041ms)","trace[692148786] 'applied index is now lower than readState.Index' (duration: 173.618252ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:12:12.311243Z","caller":"traceutil/trace.go:171","msg":"trace[774312027] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"468.509312ms","start":"2026-02-17T23:12:11.842696Z","end":"2026-02-17T23:12:12.311205Z","steps":["trace[774312027] 'process raft request' (duration: 468.378698ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:12.311329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.453175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:12:12.311362Z","caller":"traceutil/trace.go:171","msg":"trace[1842341816] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:761; }","duration":"382.529647ms","start":"2026-02-17T23:12:11.928822Z","end":"2026-02-17T23:12:12.311352Z","steps":["trace[1842341816] 'agreement among raft nodes before linearized reading' (duration: 382.439585ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:12.311372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:11.842688Z","time spent":"468.607114ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:12:12.311392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:11.928807Z","time spent":"382.577778ms","remote":"127.0.0.1:35658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T23:12:12.311562Z","caller":"traceutil/trace.go:171","msg":"trace[1567320730] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"469.935719ms","start":"2026-02-17T23:12:11.841618Z","end":"2026-02-17T23:12:12.311554Z","steps":["trace[1567320730] 'process raft request' (duration: 469.336223ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:12.311601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:11.841611Z","time spent":"469.97008ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:12:12.311633Z","caller":"traceutil/trace.go:171","msg":"trace[1832671623] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"467.912966ms","start":"2026-02-17T23:12:11.843708Z","end":"2026-02-17T23:12:12.311621Z","steps":["trace[1832671623] 'process raft request' (duration: 467.406972ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:12.311718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:11.8437Z","time spent":"467.961937ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:12:12.311797Z","caller":"traceutil/trace.go:171","msg":"trace[1822301080] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"467.624958ms","start":"2026-02-17T23:12:11.844164Z","end":"2026-02-17T23:12:12.311789Z","steps":["trace[1822301080] 'process raft request' (duration: 466.983971ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:12.311839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:11.844144Z","time spent":"467.670949ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:12:24.759032Z","caller":"traceutil/trace.go:171","msg":"trace[1674168108] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"560.527736ms","start":"2026-02-17T23:12:24.198487Z","end":"2026-02-17T23:12:24.759015Z","steps":["trace[1674168108] 'process raft request' (duration: 560.431613ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:24.759139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:24.19847Z","time spent":"560.613059ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:12:25.522201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.146363ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:12:25.522257Z","caller":"traceutil/trace.go:171","msg":"trace[419599790] linearizableReadLoop","detail":"{readStateIndex:876; appliedIndex:875; }","duration":"1.131240841s","start":"2026-02-17T23:12:24.391007Z","end":"2026-02-17T23:12:25.522248Z","steps":["trace[419599790] 'read index received' (duration: 368.375294ms)","trace[419599790] 'applied index is now lower than readState.Index' (duration: 762.864977ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:12:25.522372Z","caller":"traceutil/trace.go:171","msg":"trace[261134288] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"1.245558834s","start":"2026-02-17T23:12:24.276807Z","end":"2026-02-17T23:12:25.522366Z","steps":["trace[261134288] 'process raft request' (duration: 1.118197856s)","trace[261134288] 'compare' (duration: 127.026399ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:12:25.522404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:24.276784Z","time spent":"1.245603356s","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:12:25.522563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.131554229s","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-17T23:12:25.522578Z","caller":"traceutil/trace.go:171","msg":"trace[1460637710] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:844; }","duration":"1.13159389s","start":"2026-02-17T23:12:24.390978Z","end":"2026-02-17T23:12:25.522572Z","steps":["trace[1460637710] 'agreement among raft nodes before linearized reading' (duration: 1.131515217s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:25.522603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:24.390964Z","time spent":"1.131623801s","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T23:12:25.522697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.113714467s","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-17T23:12:25.522711Z","caller":"traceutil/trace.go:171","msg":"trace[1351246486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:844; }","duration":"1.113757858s","start":"2026-02-17T23:12:24.408948Z","end":"2026-02-17T23:12:25.522706Z","steps":["trace[1351246486] 'agreement among raft nodes before linearized reading' (duration: 1.113721277s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:25.522722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:24.408933Z","time spent":"1.113786469s","remote":"127.0.0.1:54132","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":"warn","ts":"2026-02-17T23:12:25.522825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.98766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:12:25.522839Z","caller":"traceutil/trace.go:171","msg":"trace[449355695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:844; }","duration":"597.00039ms","start":"2026-02-17T23:12:24.925833Z","end":"2026-02-17T23:12:25.522834Z","steps":["trace[449355695] 'agreement among raft nodes before linearized reading' (duration: 596.9804ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:25.522851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:24.925776Z","time spent":"597.073102ms","remote":"127.0.0.1:35658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T23:12:25.522987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.108071587s","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-17T23:12:25.523Z","caller":"traceutil/trace.go:171","msg":"trace[1702222885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:844; }","duration":"1.108120439s","start":"2026-02-17T23:12:24.414876Z","end":"2026-02-17T23:12:25.522996Z","steps":["trace[1702222885] 'agreement among raft nodes before linearized reading' (duration: 1.108080158s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:25.523024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:24.414865Z","time spent":"1.10815608s","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T23:12:25.523102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.109742833s","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-17T23:12:25.523114Z","caller":"traceutil/trace.go:171","msg":"trace[1415933498] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:844; }","duration":"1.109778083s","start":"2026-02-17T23:12:24.413332Z","end":"2026-02-17T23:12:25.523111Z","steps":["trace[1415933498] 'agreement among raft nodes before linearized reading' (duration: 1.109743142s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:25.523136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:24.413321Z","time spent":"1.109811834s","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-17T23:12:26.426805Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540732248885539,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T23:12:26.434123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.665236ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:12:26.435022Z","caller":"traceutil/trace.go:171","msg":"trace[1907492211] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"897.856767ms","start":"2026-02-17T23:12:25.537146Z","end":"2026-02-17T23:12:26.435002Z","steps":["trace[1907492211] 'process raft request' (duration: 897.672322ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:26.43513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:25.537137Z","time spent":"897.923439ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:12:26.435944Z","caller":"traceutil/trace.go:171","msg":"trace[898570650] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"903.244009ms","start":"2026-02-17T23:12:25.532673Z","end":"2026-02-17T23:12:26.435917Z","steps":["trace[898570650] 'process raft request' (duration: 131.719264ms)","trace[898570650] 'compare' (duration: 769.457521ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:12:26.436003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:25.532661Z","time spent":"903.315771ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:12:26.438796Z","caller":"traceutil/trace.go:171","msg":"trace[2104951190] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"902.420597ms","start":"2026-02-17T23:12:25.536363Z","end":"2026-02-17T23:12:26.438784Z","steps":["trace[2104951190] 'process raft request' (duration: 898.310768ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:26.438837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:25.536354Z","time spent":"902.458528ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:12:26.439287Z","caller":"traceutil/trace.go:171","msg":"trace[129589545] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"906.457004ms","start":"2026-02-17T23:12:25.53282Z","end":"2026-02-17T23:12:26.439277Z","steps":["trace[129589545] 'process raft request' (duration: 901.794181ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:26.439323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:25.532813Z","time spent":"906.488474ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:12:26.702598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.484183ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-17T23:12:26.70269Z","caller":"traceutil/trace.go:171","msg":"trace[1068441118] linearizableReadLoop","detail":"{readStateIndex:881; appliedIndex:880; }","duration":"775.920291ms","start":"2026-02-17T23:12:25.926755Z","end":"2026-02-17T23:12:26.702676Z","steps":["trace[1068441118] 'read index received' (duration: 508.894829ms)","trace[1068441118] 'applied index is now lower than readState.Index' (duration: 267.024322ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:12:26.702776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.010814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:12:26.702809Z","caller":"traceutil/trace.go:171","msg":"trace[1496552644] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:848; }","duration":"776.076626ms","start":"2026-02-17T23:12:25.926725Z","end":"2026-02-17T23:12:26.702802Z","steps":["trace[1496552644] 'agreement among raft nodes before linearized reading' (duration: 776.010644ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:26.702834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:25.926711Z","time spent":"776.117506ms","remote":"127.0.0.1:35658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T23:12:27.034992Z","caller":"traceutil/trace.go:171","msg":"trace[370304584] linearizableReadLoop","detail":"{readStateIndex:882; appliedIndex:881; }","duration":"106.271241ms","start":"2026-02-17T23:12:26.928706Z","end":"2026-02-17T23:12:27.034977Z","steps":["trace[370304584] 'read index received' (duration: 106.129797ms)","trace[370304584] 'applied index is now lower than readState.Index' (duration: 140.864µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:12:27.035082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.360853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:12:27.035097Z","caller":"traceutil/trace.go:171","msg":"trace[614403683] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:849; }","duration":"106.426475ms","start":"2026-02-17T23:12:26.928666Z","end":"2026-02-17T23:12:27.035093Z","steps":["trace[614403683] 'agreement among raft nodes before linearized reading' (duration: 106.373663ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:27.035348Z","caller":"traceutil/trace.go:171","msg":"trace[2120961482] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"270.558326ms","start":"2026-02-17T23:12:26.764783Z","end":"2026-02-17T23:12:27.035342Z","steps":["trace[2120961482] 'process raft request' (duration: 270.102994ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:30.9614Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540732248885565,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T23:12:31.06659Z","caller":"traceutil/trace.go:171","msg":"trace[1234574122] linearizableReadLoop","detail":"{readStateIndex:888; appliedIndex:887; }","duration":"605.530586ms","start":"2026-02-17T23:12:30.461045Z","end":"2026-02-17T23:12:31.066575Z","steps":["trace[1234574122] 'read index received' (duration: 605.426223ms)","trace[1234574122] 'applied index is now lower than readState.Index' (duration: 103.963µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:12:31.066658Z","caller":"traceutil/trace.go:171","msg":"trace[2008281221] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"608.206087ms","start":"2026-02-17T23:12:30.458447Z","end":"2026-02-17T23:12:31.066653Z","steps":["trace[2008281221] 'process raft request' (duration: 608.036022ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:31.066715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:30.458437Z","time spent":"608.233957ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:12:31.066799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.898289ms","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-17T23:12:31.06682Z","caller":"traceutil/trace.go:171","msg":"trace[1446135797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:855; }","duration":"604.93899ms","start":"2026-02-17T23:12:30.461875Z","end":"2026-02-17T23:12:31.066814Z","steps":["trace[1446135797] 'agreement among raft nodes before linearized reading' (duration: 604.866668ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:31.066835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:30.461866Z","time spent":"604.965391ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-17T23:12:31.066876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.976949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:12:31.066892Z","caller":"traceutil/trace.go:171","msg":"trace[757557413] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:855; }","duration":"140.992259ms","start":"2026-02-17T23:12:30.925895Z","end":"2026-02-17T23:12:31.066888Z","steps":["trace[757557413] 'agreement among raft nodes before linearized reading' (duration: 140.968398ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:31.066902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.618151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T23:12:31.066914Z","caller":"traceutil/trace.go:171","msg":"trace[592303521] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:855; }","duration":"424.654152ms","start":"2026-02-17T23:12:30.642256Z","end":"2026-02-17T23:12:31.06691Z","steps":["trace[592303521] 'agreement among raft nodes before linearized reading' (duration: 424.632331ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:31.066929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:30.642243Z","time spent":"424.682743ms","remote":"127.0.0.1:54250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":31,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-17T23:12:31.066986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.941246ms","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-17T23:12:31.066999Z","caller":"traceutil/trace.go:171","msg":"trace[2105243774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:855; }","duration":"605.979978ms","start":"2026-02-17T23:12:30.461015Z","end":"2026-02-17T23:12:31.066995Z","steps":["trace[2105243774] 'agreement among raft nodes before linearized reading' (duration: 605.941437ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:31.067015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.45187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.195\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-02-17T23:12:31.067022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:30.461007Z","time spent":"606.000258ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-17T23:12:31.067028Z","caller":"traceutil/trace.go:171","msg":"trace[687295604] range","detail":"{range_begin:/registry/masterleases/162.253.55.195; range_end:; response_count:1; response_revision:855; }","duration":"513.494702ms","start":"2026-02-17T23:12:30.553528Z","end":"2026-02-17T23:12:31.067023Z","steps":["trace[687295604] 'agreement among raft nodes before linearized reading' (duration: 513.458771ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:31.06704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:30.553514Z","time spent":"513.523622ms","remote":"127.0.0.1:35684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.195\" "} {"level":"warn","ts":"2026-02-17T23:12:31.067115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.616762ms","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-17T23:12:31.067127Z","caller":"traceutil/trace.go:171","msg":"trace[1370464306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:855; }","duration":"604.641332ms","start":"2026-02-17T23:12:30.462482Z","end":"2026-02-17T23:12:31.067123Z","steps":["trace[1370464306] 'agreement among raft nodes before linearized reading' (duration: 604.607721ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:31.067138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:30.462476Z","time spent":"604.660133ms","remote":"127.0.0.1:54132","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-17T23:12:31.280273Z","caller":"traceutil/trace.go:171","msg":"trace[788775074] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"197.038872ms","start":"2026-02-17T23:12:31.083223Z","end":"2026-02-17T23:12:31.280262Z","steps":["trace[788775074] 'process raft request' (duration: 197.015671ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:31.2803Z","caller":"traceutil/trace.go:171","msg":"trace[471376903] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"209.763758ms","start":"2026-02-17T23:12:31.07052Z","end":"2026-02-17T23:12:31.280284Z","steps":["trace[471376903] 'process raft request' (duration: 206.02868ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:31.28087Z","caller":"traceutil/trace.go:171","msg":"trace[52575603] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"208.637438ms","start":"2026-02-17T23:12:31.072221Z","end":"2026-02-17T23:12:31.280858Z","steps":["trace[52575603] 'process raft request' (duration: 207.982391ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:31.280986Z","caller":"traceutil/trace.go:171","msg":"trace[102047135] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"209.644454ms","start":"2026-02-17T23:12:31.071334Z","end":"2026-02-17T23:12:31.280978Z","steps":["trace[102047135] 'process raft request' (duration: 208.847993ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:31.281232Z","caller":"traceutil/trace.go:171","msg":"trace[1071660394] transaction","detail":"{read_only:false; response_revision:859; number_of_response:1; }","duration":"207.794716ms","start":"2026-02-17T23:12:31.073428Z","end":"2026-02-17T23:12:31.281223Z","steps":["trace[1071660394] 'process raft request' (duration: 206.789629ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:33.589223Z","caller":"traceutil/trace.go:171","msg":"trace[413426015] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"516.764437ms","start":"2026-02-17T23:12:33.072441Z","end":"2026-02-17T23:12:33.589205Z","steps":["trace[413426015] 'process raft request' (duration: 516.670204ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:33.589253Z","caller":"traceutil/trace.go:171","msg":"trace[1182419981] linearizableReadLoop","detail":"{readStateIndex:895; appliedIndex:895; }","duration":"342.364124ms","start":"2026-02-17T23:12:33.246869Z","end":"2026-02-17T23:12:33.589234Z","steps":["trace[1182419981] 'read index received' (duration: 342.358254ms)","trace[1182419981] 'applied index is now lower than readState.Index' (duration: 4.74µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:12:33.589356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:33.072431Z","time spent":"516.842789ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:12:33.589401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.507338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:12:33.589425Z","caller":"traceutil/trace.go:171","msg":"trace[383490613] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:861; }","duration":"342.573269ms","start":"2026-02-17T23:12:33.246844Z","end":"2026-02-17T23:12:33.589417Z","steps":["trace[383490613] 'agreement among raft nodes before linearized reading' (duration: 342.484557ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:33.589449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:33.246831Z","time spent":"342.611431ms","remote":"127.0.0.1:54334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-02-17T23:12:33.640686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.566731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-17T23:12:33.640693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.779606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T23:12:33.640733Z","caller":"traceutil/trace.go:171","msg":"trace[713414245] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:862; }","duration":"356.640253ms","start":"2026-02-17T23:12:33.284079Z","end":"2026-02-17T23:12:33.640719Z","steps":["trace[713414245] 'agreement among raft nodes before linearized reading' (duration: 356.49601ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:33.64075Z","caller":"traceutil/trace.go:171","msg":"trace[1207385399] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:862; }","duration":"100.878538ms","start":"2026-02-17T23:12:33.539856Z","end":"2026-02-17T23:12:33.640734Z","steps":["trace[1207385399] 'agreement among raft nodes before linearized reading' (duration: 100.767505ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:33.640758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:33.284071Z","time spent":"356.682824ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T23:12:33.640924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.173925ms","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-17T23:12:33.640938Z","caller":"traceutil/trace.go:171","msg":"trace[1608591800] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:862; }","duration":"355.188695ms","start":"2026-02-17T23:12:33.285745Z","end":"2026-02-17T23:12:33.640933Z","steps":["trace[1608591800] 'agreement among raft nodes before linearized reading' (duration: 355.146934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:33.64095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:33.285697Z","time spent":"355.250386ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-17T23:12:33.641008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.186191ms","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-17T23:12:33.641018Z","caller":"traceutil/trace.go:171","msg":"trace[1044831017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:862; }","duration":"356.204451ms","start":"2026-02-17T23:12:33.28481Z","end":"2026-02-17T23:12:33.641015Z","steps":["trace[1044831017] 'agreement among raft nodes before linearized reading' (duration: 356.16931ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:33.641029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:33.284805Z","time spent":"356.222271ms","remote":"127.0.0.1:54132","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-17T23:12:33.641039Z","caller":"traceutil/trace.go:171","msg":"trace[613065181] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"345.135439ms","start":"2026-02-17T23:12:33.295895Z","end":"2026-02-17T23:12:33.641031Z","steps":["trace[613065181] 'process raft request' (duration: 325.370726ms)","trace[613065181] 'compare' (duration: 19.232589ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:12:33.641102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:33.295887Z","time spent":"345.16719ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:12:33.64112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.790007ms","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-17T23:12:33.641133Z","caller":"traceutil/trace.go:171","msg":"trace[935322509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:862; }","duration":"356.820088ms","start":"2026-02-17T23:12:33.284309Z","end":"2026-02-17T23:12:33.641129Z","steps":["trace[935322509] 'agreement among raft nodes before linearized reading' (duration: 356.783197ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:33.641145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:33.284305Z","time spent":"356.836999ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-17T23:12:41.937391Z","caller":"traceutil/trace.go:171","msg":"trace[83526875] linearizableReadLoop","detail":"{readStateIndex:921; appliedIndex:920; }","duration":"212.09856ms","start":"2026-02-17T23:12:41.72527Z","end":"2026-02-17T23:12:41.937368Z","steps":["trace[83526875] 'read index received' (duration: 194.551615ms)","trace[83526875] 'applied index is now lower than readState.Index' (duration: 17.545955ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:12:41.937505Z","caller":"traceutil/trace.go:171","msg":"trace[1741891084] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"221.912049ms","start":"2026-02-17T23:12:41.715582Z","end":"2026-02-17T23:12:41.937494Z","steps":["trace[1741891084] 'process raft request' (duration: 204.293743ms)","trace[1741891084] 'compare' (duration: 17.121373ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:12:41.937727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.440359ms","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-17T23:12:41.93776Z","caller":"traceutil/trace.go:171","msg":"trace[1721034508] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:885; }","duration":"212.498971ms","start":"2026-02-17T23:12:41.725251Z","end":"2026-02-17T23:12:41.93775Z","steps":["trace[1721034508] 'agreement among raft nodes before linearized reading' (duration: 212.355087ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:41.93787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.297664ms","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-17T23:12:41.937919Z","caller":"traceutil/trace.go:171","msg":"trace[52796897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:885; }","duration":"204.365295ms","start":"2026-02-17T23:12:41.733541Z","end":"2026-02-17T23:12:41.937906Z","steps":["trace[52796897] 'agreement among raft nodes before linearized reading' (duration: 204.237422ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:41.938022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.376659ms","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-17T23:12:41.938037Z","caller":"traceutil/trace.go:171","msg":"trace[803029234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:885; }","duration":"203.40342ms","start":"2026-02-17T23:12:41.734629Z","end":"2026-02-17T23:12:41.938033Z","steps":["trace[803029234] 'agreement among raft nodes before linearized reading' (duration: 203.359129ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:42.188583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.312098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:12:42.188662Z","caller":"traceutil/trace.go:171","msg":"trace[1158301794] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:888; }","duration":"124.423731ms","start":"2026-02-17T23:12:42.064221Z","end":"2026-02-17T23:12:42.188645Z","steps":["trace[1158301794] 'count revisions from in-memory index tree' (duration: 124.258706ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:43.849124Z","caller":"traceutil/trace.go:171","msg":"trace[1340679739] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"177.828544ms","start":"2026-02-17T23:12:43.671278Z","end":"2026-02-17T23:12:43.849106Z","steps":["trace[1340679739] 'process raft request' (duration: 177.728111ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:44.12026Z","caller":"traceutil/trace.go:171","msg":"trace[496593714] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"165.396274ms","start":"2026-02-17T23:12:43.954841Z","end":"2026-02-17T23:12:44.120237Z","steps":["trace[496593714] 'process raft request' (duration: 164.224503ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:44.227374Z","caller":"traceutil/trace.go:171","msg":"trace[1766652625] linearizableReadLoop","detail":"{readStateIndex:928; appliedIndex:927; }","duration":"221.521768ms","start":"2026-02-17T23:12:44.005836Z","end":"2026-02-17T23:12:44.227358Z","steps":["trace[1766652625] 'read index received' (duration: 114.805266ms)","trace[1766652625] 'applied index is now lower than readState.Index' (duration: 106.715832ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:12:44.240491Z","caller":"traceutil/trace.go:171","msg":"trace[1134293922] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"284.73284ms","start":"2026-02-17T23:12:43.955734Z","end":"2026-02-17T23:12:44.240467Z","steps":["trace[1134293922] 'process raft request' (duration: 269.121147ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:44.240777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.926953ms","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-17T23:12:44.240805Z","caller":"traceutil/trace.go:171","msg":"trace[516717792] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:892; }","duration":"234.991055ms","start":"2026-02-17T23:12:44.005806Z","end":"2026-02-17T23:12:44.240797Z","steps":["trace[516717792] 'agreement among raft nodes before linearized reading' (duration: 234.869321ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:44.240926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.083967ms","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-17T23:12:44.240947Z","caller":"traceutil/trace.go:171","msg":"trace[669342091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:892; }","duration":"207.134039ms","start":"2026-02-17T23:12:44.033808Z","end":"2026-02-17T23:12:44.240942Z","steps":["trace[669342091] 'agreement among raft nodes before linearized reading' (duration: 207.083237ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:44.241096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.207754ms","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-17T23:12:44.241121Z","caller":"traceutil/trace.go:171","msg":"trace[373328328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:892; }","duration":"206.250745ms","start":"2026-02-17T23:12:44.034862Z","end":"2026-02-17T23:12:44.241113Z","steps":["trace[373328328] 'agreement among raft nodes before linearized reading' (duration: 206.198114ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:44.810135Z","caller":"traceutil/trace.go:171","msg":"trace[1184585569] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"552.620637ms","start":"2026-02-17T23:12:44.257499Z","end":"2026-02-17T23:12:44.81012Z","steps":["trace[1184585569] 'process raft request' (duration: 552.594056ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:44.81023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:44.257492Z","time spent":"552.685748ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:12:44.810401Z","caller":"traceutil/trace.go:171","msg":"trace[1470329100] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"554.097226ms","start":"2026-02-17T23:12:44.256298Z","end":"2026-02-17T23:12:44.810396Z","steps":["trace[1470329100] 'process raft request' (duration: 553.714526ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:12:44.810427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:44.256287Z","time spent":"554.124887ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:12:46.356008Z","caller":"traceutil/trace.go:171","msg":"trace[225243950] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"102.803649ms","start":"2026-02-17T23:12:46.253182Z","end":"2026-02-17T23:12:46.355986Z","steps":["trace[225243950] 'process raft request' (duration: 102.681446ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:12:59.248557Z","caller":"traceutil/trace.go:171","msg":"trace[953240863] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"204.668223ms","start":"2026-02-17T23:12:59.043868Z","end":"2026-02-17T23:12:59.248536Z","steps":["trace[953240863] 'process raft request' (duration: 204.511849ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:00.814219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.635929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"} {"level":"info","ts":"2026-02-17T23:13:00.814269Z","caller":"traceutil/trace.go:171","msg":"trace[311674714] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1000; }","duration":"911.735352ms","start":"2026-02-17T23:12:59.90252Z","end":"2026-02-17T23:13:00.814256Z","steps":["trace[311674714] 'range keys from in-memory index tree' (duration: 911.508876ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:00.81432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:59.902505Z","time spent":"911.807934ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":551,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-17T23:13:00.814488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.792394ms","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-17T23:13:00.814506Z","caller":"traceutil/trace.go:171","msg":"trace[1020851628] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1000; }","duration":"911.834125ms","start":"2026-02-17T23:12:59.902667Z","end":"2026-02-17T23:13:00.814501Z","steps":["trace[1020851628] 'range keys from in-memory index tree' (duration: 911.65996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:00.814518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:59.902378Z","time spent":"912.137193ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T23:13:00.815178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.178846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:13:00.815197Z","caller":"traceutil/trace.go:171","msg":"trace[4984577] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1000; }","duration":"886.226798ms","start":"2026-02-17T23:12:59.928964Z","end":"2026-02-17T23:13:00.815191Z","steps":["trace[4984577] 'range keys from in-memory index tree' (duration: 886.118395ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:00.81527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:12:59.928949Z","time spent":"886.31474ms","remote":"127.0.0.1:35658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T23:13:00.81548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.162411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-02-17T23:13:00.815497Z","caller":"traceutil/trace.go:171","msg":"trace[201245390] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1000; }","duration":"564.182542ms","start":"2026-02-17T23:13:00.25131Z","end":"2026-02-17T23:13:00.815493Z","steps":["trace[201245390] 'range keys from in-memory index tree' (duration: 564.044427ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:00.816187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:13:00.251221Z","time spent":"564.959902ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-17T23:13:00.816355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.983516ms","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-17T23:13:00.816373Z","caller":"traceutil/trace.go:171","msg":"trace[1167619303] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1000; }","duration":"378.037658ms","start":"2026-02-17T23:13:00.43833Z","end":"2026-02-17T23:13:00.816367Z","steps":["trace[1167619303] 'range keys from in-memory index tree' (duration: 377.909874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:00.816439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:13:00.438311Z","time spent":"378.12254ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T23:13:00.816543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.360479ms","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-17T23:13:00.816571Z","caller":"traceutil/trace.go:171","msg":"trace[847459543] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1000; }","duration":"363.40714ms","start":"2026-02-17T23:13:00.453159Z","end":"2026-02-17T23:13:00.816566Z","steps":["trace[847459543] 'range keys from in-memory index tree' (duration: 363.294028ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:00.816584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:13:00.453144Z","time spent":"363.437221ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-17T23:13:00.816936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.39691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.195\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-17T23:13:00.816956Z","caller":"traceutil/trace.go:171","msg":"trace[1331737036] range","detail":"{range_begin:/registry/masterleases/162.253.55.195; range_end:; response_count:1; response_revision:1000; }","duration":"262.458251ms","start":"2026-02-17T23:13:00.554492Z","end":"2026-02-17T23:13:00.816951Z","steps":["trace[1331737036] 'range keys from in-memory index tree' (duration: 262.196304ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:13:01.296995Z","caller":"traceutil/trace.go:171","msg":"trace[1982992873] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1040; }","duration":"395.114701ms","start":"2026-02-17T23:13:00.901863Z","end":"2026-02-17T23:13:01.296978Z","steps":["trace[1982992873] 'read index received' (duration: 394.617187ms)","trace[1982992873] 'applied index is now lower than readState.Index' (duration: 496.884µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:13:01.298425Z","caller":"traceutil/trace.go:171","msg":"trace[1453855939] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"472.604941ms","start":"2026-02-17T23:13:00.825811Z","end":"2026-02-17T23:13:01.298416Z","steps":["trace[1453855939] 'process raft request' (duration: 471.092821ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:01.298728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:13:00.825808Z","time spent":"472.756835ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:13:01.298325Z","caller":"traceutil/trace.go:171","msg":"trace[1036502839] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"472.58599ms","start":"2026-02-17T23:13:00.825718Z","end":"2026-02-17T23:13:01.298304Z","steps":["trace[1036502839] 'process raft request' (duration: 470.32491ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:01.299087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:13:00.825703Z","time spent":"473.304719ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:13:01.299588Z","caller":"traceutil/trace.go:171","msg":"trace[2079476657] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"473.72285ms","start":"2026-02-17T23:13:00.825841Z","end":"2026-02-17T23:13:01.299563Z","steps":["trace[2079476657] 'process raft request' (duration: 471.08894ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:01.300046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:13:00.825836Z","time spent":"473.820582ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:13:01.300397Z","caller":"traceutil/trace.go:171","msg":"trace[1206511091] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"473.255958ms","start":"2026-02-17T23:13:00.827131Z","end":"2026-02-17T23:13:01.300387Z","steps":["trace[1206511091] 'process raft request' (duration: 469.821687ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:01.30048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:13:00.827122Z","time spent":"473.299279ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":512,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:13:01.300789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.922202ms","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-17T23:13:01.300823Z","caller":"traceutil/trace.go:171","msg":"trace[1197811558] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1005; }","duration":"398.995364ms","start":"2026-02-17T23:13:00.90182Z","end":"2026-02-17T23:13:01.300815Z","steps":["trace[1197811558] 'agreement among raft nodes before linearized reading' (duration: 398.868391ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:01.302954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:13:00.901805Z","time spent":"401.13706ms","remote":"127.0.0.1:54132","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-17T23:13:01.297225Z","caller":"traceutil/trace.go:171","msg":"trace[1074098290] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"471.43282ms","start":"2026-02-17T23:13:00.825781Z","end":"2026-02-17T23:13:01.297214Z","steps":["trace[1074098290] 'process raft request' (duration: 471.04676ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:01.303402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:13:00.825777Z","time spent":"477.533371ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:13:01.307313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.695193ms","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-17T23:13:01.308062Z","caller":"traceutil/trace.go:171","msg":"trace[1918985202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1006; }","duration":"397.471363ms","start":"2026-02-17T23:13:00.910575Z","end":"2026-02-17T23:13:01.308046Z","steps":["trace[1918985202] 'agreement among raft nodes before linearized reading' (duration: 396.22067ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:01.308166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:13:00.910564Z","time spent":"397.591316ms","remote":"127.0.0.1:54132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-17T23:13:01.308824Z","caller":"traceutil/trace.go:171","msg":"trace[967716380] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"405.900477ms","start":"2026-02-17T23:13:00.90291Z","end":"2026-02-17T23:13:01.308811Z","steps":["trace[967716380] 'process raft request' (duration: 401.328846ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:01.309019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:13:00.902893Z","time spent":"406.05657ms","remote":"127.0.0.1:35684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:13:01.309347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.405406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:13:01.309762Z","caller":"traceutil/trace.go:171","msg":"trace[1174352913] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1006; }","duration":"379.851218ms","start":"2026-02-17T23:13:00.929903Z","end":"2026-02-17T23:13:01.309755Z","steps":["trace[1174352913] 'agreement among raft nodes before linearized reading' (duration: 379.430627ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:01.309803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:13:00.929888Z","time spent":"379.907659ms","remote":"127.0.0.1:35658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T23:13:06.506595Z","caller":"traceutil/trace.go:171","msg":"trace[2117147933] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"166.269458ms","start":"2026-02-17T23:13:06.340295Z","end":"2026-02-17T23:13:06.506564Z","steps":["trace[2117147933] 'process raft request' (duration: 112.904646ms)","trace[2117147933] 'compare' (duration: 53.148637ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:13:44.016926Z","caller":"traceutil/trace.go:171","msg":"trace[258975735] linearizableReadLoop","detail":"{readStateIndex:1229; appliedIndex:1228; }","duration":"160.787092ms","start":"2026-02-17T23:13:43.856121Z","end":"2026-02-17T23:13:44.016908Z","steps":["trace[258975735] 'read index received' (duration: 88.813915ms)","trace[258975735] 'applied index is now lower than readState.Index' (duration: 71.972657ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:13:44.017016Z","caller":"traceutil/trace.go:171","msg":"trace[85412384] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"162.448226ms","start":"2026-02-17T23:13:43.854559Z","end":"2026-02-17T23:13:44.017007Z","steps":["trace[85412384] 'process raft request' (duration: 90.420268ms)","trace[85412384] 'compare' (duration: 71.850113ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:13:44.01728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.145251ms","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-17T23:13:44.017298Z","caller":"traceutil/trace.go:171","msg":"trace[1133686668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1181; }","duration":"161.198203ms","start":"2026-02-17T23:13:43.856095Z","end":"2026-02-17T23:13:44.017293Z","steps":["trace[1133686668] 'agreement among raft nodes before linearized reading' (duration: 161.115021ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:13:46.104769Z","caller":"traceutil/trace.go:171","msg":"trace[1107167935] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"215.855158ms","start":"2026-02-17T23:13:45.888887Z","end":"2026-02-17T23:13:46.104742Z","steps":["trace[1107167935] 'process raft request' (duration: 146.981763ms)","trace[1107167935] 'compare' (duration: 68.365642ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:13:46.12928Z","caller":"traceutil/trace.go:171","msg":"trace[700423504] linearizableReadLoop","detail":"{readStateIndex:1236; appliedIndex:1234; }","duration":"201.981956ms","start":"2026-02-17T23:13:45.927274Z","end":"2026-02-17T23:13:46.129256Z","steps":["trace[700423504] 'read index received' (duration: 108.606682ms)","trace[700423504] 'applied index is now lower than readState.Index' (duration: 93.373904ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:13:46.129431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.14778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:13:46.129468Z","caller":"traceutil/trace.go:171","msg":"trace[1184344948] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1187; }","duration":"202.243213ms","start":"2026-02-17T23:13:45.927215Z","end":"2026-02-17T23:13:46.129459Z","steps":["trace[1184344948] 'agreement among raft nodes before linearized reading' (duration: 202.173192ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:46.129739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.684034ms","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-17T23:13:46.129777Z","caller":"traceutil/trace.go:171","msg":"trace[1551063756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1187; }","duration":"108.753285ms","start":"2026-02-17T23:13:46.021012Z","end":"2026-02-17T23:13:46.129765Z","steps":["trace[1551063756] 'agreement among raft nodes before linearized reading' (duration: 108.649413ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:13:55.919986Z","caller":"traceutil/trace.go:171","msg":"trace[128288508] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"120.120242ms","start":"2026-02-17T23:13:55.799848Z","end":"2026-02-17T23:13:55.919968Z","steps":["trace[128288508] 'process raft request' (duration: 120.02711ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:13:55.920156Z","caller":"traceutil/trace.go:171","msg":"trace[1040125285] linearizableReadLoop","detail":"{readStateIndex:1274; appliedIndex:1274; }","duration":"117.867904ms","start":"2026-02-17T23:13:55.802268Z","end":"2026-02-17T23:13:55.920136Z","steps":["trace[1040125285] 'read index received' (duration: 117.859583ms)","trace[1040125285] 'applied index is now lower than readState.Index' (duration: 6.611µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:13:55.920559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.273104ms","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-17T23:13:55.92064Z","caller":"traceutil/trace.go:171","msg":"trace[701016073] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1224; }","duration":"118.406988ms","start":"2026-02-17T23:13:55.802224Z","end":"2026-02-17T23:13:55.920631Z","steps":["trace[701016073] 'agreement among raft nodes before linearized reading' (duration: 118.146901ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:13:56.019616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.44032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:13:56.019695Z","caller":"traceutil/trace.go:171","msg":"trace[2118672556] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1225; }","duration":"171.561903ms","start":"2026-02-17T23:13:55.848115Z","end":"2026-02-17T23:13:56.019677Z","steps":["trace[2118672556] 'agreement among raft nodes before linearized reading' (duration: 171.392429ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:13:56.205598Z","caller":"traceutil/trace.go:171","msg":"trace[374338737] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"176.924113ms","start":"2026-02-17T23:13:56.028651Z","end":"2026-02-17T23:13:56.205575Z","steps":["trace[374338737] 'process raft request' (duration: 90.969072ms)","trace[374338737] 'compare' (duration: 85.717865ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:13:58.318385Z","caller":"traceutil/trace.go:171","msg":"trace[830743599] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"100.548412ms","start":"2026-02-17T23:13:58.217814Z","end":"2026-02-17T23:13:58.318363Z","steps":["trace[830743599] 'process raft request' (duration: 100.212873ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:14:06.60175Z","caller":"traceutil/trace.go:171","msg":"trace[1703511820] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"108.529059ms","start":"2026-02-17T23:14:06.493199Z","end":"2026-02-17T23:14:06.601728Z","steps":["trace[1703511820] 'process raft request' (duration: 39.262373ms)","trace[1703511820] 'compare' (duration: 68.64044ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:15:50.844128Z","caller":"traceutil/trace.go:171","msg":"trace[1147402740] transaction","detail":"{read_only:false; response_revision:1697; number_of_response:1; }","duration":"141.227295ms","start":"2026-02-17T23:15:50.702875Z","end":"2026-02-17T23:15:50.844102Z","steps":["trace[1147402740] 'process raft request' (duration: 55.197208ms)","trace[1147402740] 'compare' (duration: 85.933585ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:16:01.451299Z","caller":"traceutil/trace.go:171","msg":"trace[313505398] transaction","detail":"{read_only:false; response_revision:1763; number_of_response:1; }","duration":"192.966122ms","start":"2026-02-17T23:16:01.258304Z","end":"2026-02-17T23:16:01.45127Z","steps":["trace[313505398] 'process raft request' (duration: 192.851949ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:16:01.454994Z","caller":"traceutil/trace.go:171","msg":"trace[2012311185] transaction","detail":"{read_only:false; response_revision:1765; number_of_response:1; }","duration":"196.528056ms","start":"2026-02-17T23:16:01.258455Z","end":"2026-02-17T23:16:01.454983Z","steps":["trace[2012311185] 'process raft request' (duration: 196.456964ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:16:01.455234Z","caller":"traceutil/trace.go:171","msg":"trace[880995610] transaction","detail":"{read_only:false; response_revision:1764; number_of_response:1; }","duration":"196.827434ms","start":"2026-02-17T23:16:01.258396Z","end":"2026-02-17T23:16:01.455224Z","steps":["trace[880995610] 'process raft request' (duration: 196.446934ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:16:01.931061Z","caller":"traceutil/trace.go:171","msg":"trace[1357442181] transaction","detail":"{read_only:false; response_revision:1766; number_of_response:1; }","duration":"127.783752ms","start":"2026-02-17T23:16:01.803261Z","end":"2026-02-17T23:16:01.931045Z","steps":["trace[1357442181] 'process raft request' (duration: 127.69571ms)"],"step_count":1}