{"level":"warn","ts":"2026-02-18T19:43:23.485083Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-18T19:43:23.485752Z","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-18T19:43:23.486215Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-18T19:43:23.486929Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-02-18T19:43:23.487056Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-18T19:43:23.487907Z","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-18T19:43:23.491222Z","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-18T19:43:23.497341Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.771193ms"} {"level":"info","ts":"2026-02-18T19:43:23.521443Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b66d12fd59101739","cluster-id":"a64a525934ce8379"} {"level":"info","ts":"2026-02-18T19:43:23.521631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=()"} {"level":"info","ts":"2026-02-18T19:43:23.521663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 0"} {"level":"info","ts":"2026-02-18T19:43:23.521731Z","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-18T19:43:23.521789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 1"} {"level":"info","ts":"2026-02-18T19:43:23.521937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"warn","ts":"2026-02-18T19:43:23.532008Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-18T19:43:23.543496Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-18T19:43:23.550484Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-02-18T19:43:23.556662Z","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-18T19:43:23.560551Z","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-18T19:43:23.561202Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-18T19:43:23.561489Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-18T19:43:23.561789Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-18T19:43:23.579378Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-18T19:43:23.577441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"info","ts":"2026-02-18T19:43:23.580743Z","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-18T19:43:23.58085Z","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-18T19:43:23.580989Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-02-18T19:43:23.581847Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-02-18T19:43:23.583539Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-18T19:43:24.18918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 is starting a new election at term 1"} {"level":"info","ts":"2026-02-18T19:43:24.189253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-18T19:43:24.189274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgPreVoteResp from b66d12fd59101739 at term 1"} {"level":"info","ts":"2026-02-18T19:43:24.18929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became candidate at term 2"} {"level":"info","ts":"2026-02-18T19:43:24.189296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgVoteResp from b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-02-18T19:43:24.189306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became leader at term 2"} {"level":"info","ts":"2026-02-18T19:43:24.18932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b66d12fd59101739 elected leader b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-02-18T19:43:24.282164Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T19:43:24.282476Z","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-18T19:43:24.282606Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T19:43:24.283258Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-18T19:43:24.283345Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-18T19:43:24.282765Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T19:43:24.28761Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-18T19:43:24.290473Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.195:2379"} {"level":"info","ts":"2026-02-18T19:43:24.398137Z","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-18T19:43:24.398724Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T19:43:24.398788Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T19:43:29.357158Z","caller":"traceutil/trace.go:171","msg":"trace[1444585022] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"167.083073ms","start":"2026-02-18T19:43:29.190027Z","end":"2026-02-18T19:43:29.35711Z","steps":["trace[1444585022] 'process raft request' (duration: 166.82158ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:30.558465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.540129ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:43:30.558726Z","caller":"traceutil/trace.go:171","msg":"trace[618669413] linearizableReadLoop","detail":"{readStateIndex:215; appliedIndex:214; }","duration":"986.529073ms","start":"2026-02-18T19:43:29.572181Z","end":"2026-02-18T19:43:30.55871Z","steps":["trace[618669413] 'read index received' (duration: 171.432588ms)","trace[618669413] 'applied index is now lower than readState.Index' (duration: 815.095445ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:43:30.558933Z","caller":"traceutil/trace.go:171","msg":"trace[1859768293] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"1.191587073s","start":"2026-02-18T19:43:29.367335Z","end":"2026-02-18T19:43:30.558923Z","steps":["trace[1859768293] 'process raft request' (duration: 376.239185ms)","trace[1859768293] 'compare' (duration: 813.684859ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:43:30.559083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:43:29.367324Z","time spent":"1.191736404s","remote":"127.0.0.1:51424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T19:43:30.559347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.16925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:43:30.559432Z","caller":"traceutil/trace.go:171","msg":"trace[1431000105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:210; }","duration":"987.303632ms","start":"2026-02-18T19:43:29.572117Z","end":"2026-02-18T19:43:30.559421Z","steps":["trace[1431000105] 'agreement among raft nodes before linearized reading' (duration: 987.17385ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:30.55952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:43:29.572089Z","time spent":"987.423493ms","remote":"127.0.0.1:51592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-18T19:43:30.559716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.24072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:43:30.559803Z","caller":"traceutil/trace.go:171","msg":"trace[371013914] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:210; }","duration":"709.364841ms","start":"2026-02-18T19:43:29.85043Z","end":"2026-02-18T19:43:30.559795Z","steps":["trace[371013914] 'agreement among raft nodes before linearized reading' (duration: 709.26744ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:30.559889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:43:29.850408Z","time spent":"709.473423ms","remote":"127.0.0.1:51592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-18T19:43:30.560081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.237579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:43:30.560163Z","caller":"traceutil/trace.go:171","msg":"trace[44024939] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:210; }","duration":"276.360369ms","start":"2026-02-18T19:43:30.283794Z","end":"2026-02-18T19:43:30.560154Z","steps":["trace[44024939] 'agreement among raft nodes before linearized reading' (duration: 276.268338ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:30.56032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.409822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:43:30.560399Z","caller":"traceutil/trace.go:171","msg":"trace[1975349899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:210; }","duration":"381.527613ms","start":"2026-02-18T19:43:30.178862Z","end":"2026-02-18T19:43:30.560389Z","steps":["trace[1975349899] 'agreement among raft nodes before linearized reading' (duration: 381.439552ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:30.560483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:43:30.178838Z","time spent":"381.635594ms","remote":"127.0.0.1:51592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-18T19:43:31.401243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.301196ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:43:31.401348Z","caller":"traceutil/trace.go:171","msg":"trace[2087567263] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"138.926177ms","start":"2026-02-18T19:43:31.26241Z","end":"2026-02-18T19:43:31.401336Z","steps":["trace[2087567263] 'process raft request' (duration: 138.898477ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:43:31.401482Z","caller":"traceutil/trace.go:171","msg":"trace[1036794672] linearizableReadLoop","detail":"{readStateIndex:254; appliedIndex:253; }","duration":"139.877576ms","start":"2026-02-18T19:43:31.26157Z","end":"2026-02-18T19:43:31.401447Z","steps":["trace[1036794672] 'read index received' (duration: 24.390578ms)","trace[1036794672] 'applied index is now lower than readState.Index' (duration: 115.483128ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:43:31.401524Z","caller":"traceutil/trace.go:171","msg":"trace[337151212] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"157.08613ms","start":"2026-02-18T19:43:31.244431Z","end":"2026-02-18T19:43:31.401517Z","steps":["trace[337151212] 'process raft request' (duration: 41.46008ms)","trace[337151212] 'compare' (duration: 115.198615ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:43:31.401698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.104578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-18T19:43:31.401725Z","caller":"traceutil/trace.go:171","msg":"trace[890454782] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:249; }","duration":"140.18651ms","start":"2026-02-18T19:43:31.261529Z","end":"2026-02-18T19:43:31.401716Z","steps":["trace[890454782] 'agreement among raft nodes before linearized reading' (duration: 140.045318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:31.426525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.213503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:43:31.426576Z","caller":"traceutil/trace.go:171","msg":"trace[2056617142] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:0; response_revision:252; }","duration":"161.298825ms","start":"2026-02-18T19:43:31.265264Z","end":"2026-02-18T19:43:31.426563Z","steps":["trace[2056617142] 'agreement among raft nodes before linearized reading' (duration: 161.164294ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:31.426703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.476091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:43:31.426723Z","caller":"traceutil/trace.go:171","msg":"trace[798981808] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:252; }","duration":"154.506252ms","start":"2026-02-18T19:43:31.272209Z","end":"2026-02-18T19:43:31.426716Z","steps":["trace[798981808] 'agreement among raft nodes before linearized reading' (duration: 154.471351ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:31.732416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.510424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:43:31.732549Z","caller":"traceutil/trace.go:171","msg":"trace[956910110] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:0; response_revision:263; }","duration":"156.652255ms","start":"2026-02-18T19:43:31.57585Z","end":"2026-02-18T19:43:31.732503Z","steps":["trace[956910110] 'agreement among raft nodes before linearized reading' (duration: 83.041763ms)","trace[956910110] 'range keys from in-memory index tree' (duration: 73.466441ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:43:31.739373Z","caller":"traceutil/trace.go:171","msg":"trace[438507223] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"158.903718ms","start":"2026-02-18T19:43:31.580438Z","end":"2026-02-18T19:43:31.739342Z","steps":["trace[438507223] 'process raft request' (duration: 85.64886ms)","trace[438507223] 'compare' (duration: 66.092753ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:43:44.283493Z","caller":"traceutil/trace.go:171","msg":"trace[1230062491] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"121.094212ms","start":"2026-02-18T19:43:44.16236Z","end":"2026-02-18T19:43:44.283455Z","steps":["trace[1230062491] 'process raft request' (duration: 68.409399ms)","trace[1230062491] 'compare' (duration: 52.461116ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:43:44.283897Z","caller":"traceutil/trace.go:171","msg":"trace[2126711718] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"117.432643ms","start":"2026-02-18T19:43:44.166438Z","end":"2026-02-18T19:43:44.283871Z","steps":["trace[2126711718] 'process raft request' (duration: 117.385051ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:43:44.284066Z","caller":"traceutil/trace.go:171","msg":"trace[1899927173] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"121.660028ms","start":"2026-02-18T19:43:44.162395Z","end":"2026-02-18T19:43:44.284055Z","steps":["trace[1899927173] 'process raft request' (duration: 121.008049ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:43:44.284126Z","caller":"traceutil/trace.go:171","msg":"trace[730535879] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"118.711731ms","start":"2026-02-18T19:43:44.165407Z","end":"2026-02-18T19:43:44.284119Z","steps":["trace[730535879] 'process raft request' (duration: 118.306189ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:43:44.284226Z","caller":"traceutil/trace.go:171","msg":"trace[821120552] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"117.837435ms","start":"2026-02-18T19:43:44.166383Z","end":"2026-02-18T19:43:44.28422Z","steps":["trace[821120552] 'process raft request' (duration: 117.412693ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:43:46.926549Z","caller":"traceutil/trace.go:171","msg":"trace[839464141] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"127.80913ms","start":"2026-02-18T19:43:46.798675Z","end":"2026-02-18T19:43:46.926484Z","steps":["trace[839464141] 'read index received' (duration: 67.834284ms)","trace[839464141] 'applied index is now lower than readState.Index' (duration: 59.974056ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:43:46.926703Z","caller":"traceutil/trace.go:171","msg":"trace[1746460973] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"148.941314ms","start":"2026-02-18T19:43:46.777752Z","end":"2026-02-18T19:43:46.926693Z","steps":["trace[1746460973] 'process raft request' (duration: 148.507202ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:43:46.927031Z","caller":"traceutil/trace.go:171","msg":"trace[426028994] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"102.700359ms","start":"2026-02-18T19:43:46.82432Z","end":"2026-02-18T19:43:46.927021Z","steps":["trace[426028994] 'process raft request' (duration: 102.119903ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:46.93158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.388976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T19:43:46.931801Z","caller":"traceutil/trace.go:171","msg":"trace[133539070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:416; }","duration":"129.647093ms","start":"2026-02-18T19:43:46.802117Z","end":"2026-02-18T19:43:46.931764Z","steps":["trace[133539070] 'agreement among raft nodes before linearized reading' (duration: 125.124512ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:46.932903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.01536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-18T19:43:46.932948Z","caller":"traceutil/trace.go:171","msg":"trace[1478224197] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:416; }","duration":"134.298038ms","start":"2026-02-18T19:43:46.798635Z","end":"2026-02-18T19:43:46.932933Z","steps":["trace[1478224197] 'agreement among raft nodes before linearized reading' (duration: 128.586162ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:43:55.456641Z","caller":"traceutil/trace.go:171","msg":"trace[1636048094] linearizableReadLoop","detail":"{readStateIndex:448; appliedIndex:447; }","duration":"438.511588ms","start":"2026-02-18T19:43:55.018108Z","end":"2026-02-18T19:43:55.45662Z","steps":["trace[1636048094] 'read index received' (duration: 438.328243ms)","trace[1636048094] 'applied index is now lower than readState.Index' (duration: 182.635µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:43:55.456851Z","caller":"traceutil/trace.go:171","msg":"trace[282491523] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"476.965684ms","start":"2026-02-18T19:43:54.979879Z","end":"2026-02-18T19:43:55.456845Z","steps":["trace[282491523] 'process raft request' (duration: 476.627435ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:55.457088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:43:54.979865Z","time spent":"477.003354ms","remote":"127.0.0.1:51592","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-18T19:43:55.457209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.115854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-18T19:43:55.457228Z","caller":"traceutil/trace.go:171","msg":"trace[1628677031] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:433; }","duration":"439.161655ms","start":"2026-02-18T19:43:55.01806Z","end":"2026-02-18T19:43:55.457222Z","steps":["trace[1628677031] 'agreement among raft nodes before linearized reading' (duration: 439.126124ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:55.457259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:43:55.018028Z","time spent":"439.227456ms","remote":"127.0.0.1:51592","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-18T19:43:55.457332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.922614ms","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-18T19:43:55.457344Z","caller":"traceutil/trace.go:171","msg":"trace[1566639134] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:433; }","duration":"402.976576ms","start":"2026-02-18T19:43:55.054363Z","end":"2026-02-18T19:43:55.45734Z","steps":["trace[1566639134] 'agreement among raft nodes before linearized reading' (duration: 402.951935ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:55.457356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:43:55.054338Z","time spent":"403.015587ms","remote":"127.0.0.1:51592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-18T19:43:55.457443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.405522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-18T19:43:55.457457Z","caller":"traceutil/trace.go:171","msg":"trace[1892023817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:433; }","duration":"403.833299ms","start":"2026-02-18T19:43:55.05362Z","end":"2026-02-18T19:43:55.457454Z","steps":["trace[1892023817] 'agreement among raft nodes before linearized reading' (duration: 403.805948ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:55.457469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:43:55.053604Z","time spent":"403.862639ms","remote":"127.0.0.1:51592","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-18T19:43:56.349399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.803272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:43:56.349972Z","caller":"traceutil/trace.go:171","msg":"trace[1223491516] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"887.79486ms","start":"2026-02-18T19:43:55.462155Z","end":"2026-02-18T19:43:56.34995Z","steps":["trace[1223491516] 'process raft request' (duration: 529.355111ms)","trace[1223491516] 'compare' (duration: 357.443452ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:43:56.350253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:43:55.462138Z","time spent":"888.071267ms","remote":"127.0.0.1:51592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:43:56.351075Z","caller":"traceutil/trace.go:171","msg":"trace[612876302] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"888.651953ms","start":"2026-02-18T19:43:55.462412Z","end":"2026-02-18T19:43:56.351064Z","steps":["trace[612876302] 'process raft request' (duration: 887.501142ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:56.3513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:43:55.462405Z","time spent":"888.854558ms","remote":"127.0.0.1:51592","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-18T19:43:56.351902Z","caller":"traceutil/trace.go:171","msg":"trace[50430514] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"882.97322ms","start":"2026-02-18T19:43:55.468914Z","end":"2026-02-18T19:43:56.351888Z","steps":["trace[50430514] 'process raft request' (duration: 881.850081ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:56.352116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:43:55.468907Z","time spent":"883.166286ms","remote":"127.0.0.1:51592","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-18T19:43:56.3525Z","caller":"traceutil/trace.go:171","msg":"trace[1798549298] linearizableReadLoop","detail":"{readStateIndex:451; appliedIndex:448; }","duration":"360.988798ms","start":"2026-02-18T19:43:55.98997Z","end":"2026-02-18T19:43:56.350959Z","steps":["trace[1798549298] 'read index received' (duration: 1.616794ms)","trace[1798549298] 'applied index is now lower than readState.Index' (duration: 359.371204ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:43:56.352753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.808446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:43:56.353004Z","caller":"traceutil/trace.go:171","msg":"trace[140493833] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:0; response_revision:436; }","duration":"363.060403ms","start":"2026-02-18T19:43:55.989929Z","end":"2026-02-18T19:43:56.35299Z","steps":["trace[140493833] 'agreement among raft nodes before linearized reading' (duration: 362.772545ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:56.353163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:43:55.989861Z","time spent":"363.261759ms","remote":"127.0.0.1:51512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium\" "} {"level":"info","ts":"2026-02-18T19:43:56.554151Z","caller":"traceutil/trace.go:171","msg":"trace[912354675] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"114.560652ms","start":"2026-02-18T19:43:56.439565Z","end":"2026-02-18T19:43:56.554126Z","steps":["trace[912354675] 'process raft request' (duration: 113.32428ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:43:56.951187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.537285ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:43:56.951307Z","caller":"traceutil/trace.go:171","msg":"trace[92050814] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"179.979649ms","start":"2026-02-18T19:43:56.771309Z","end":"2026-02-18T19:43:56.951288Z","steps":["trace[92050814] 'process raft request' (duration: 60.27048ms)","trace[92050814] 'compare' (duration: 118.885227ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:44:00.494911Z","caller":"traceutil/trace.go:171","msg":"trace[964091677] linearizableReadLoop","detail":"{readStateIndex:517; appliedIndex:516; }","duration":"125.732614ms","start":"2026-02-18T19:44:00.369152Z","end":"2026-02-18T19:44:00.494885Z","steps":["trace[964091677] 'read index received' (duration: 125.473737ms)","trace[964091677] 'applied index is now lower than readState.Index' (duration: 258.077µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:44:00.495035Z","caller":"traceutil/trace.go:171","msg":"trace[1426034281] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"138.971182ms","start":"2026-02-18T19:44:00.356057Z","end":"2026-02-18T19:44:00.495029Z","steps":["trace[1426034281] 'process raft request' (duration: 138.681345ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:00.495291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.991156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T19:44:00.495396Z","caller":"traceutil/trace.go:171","msg":"trace[1889561596] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:501; }","duration":"113.14168ms","start":"2026-02-18T19:44:00.382203Z","end":"2026-02-18T19:44:00.495345Z","steps":["trace[1889561596] 'agreement among raft nodes before linearized reading' (duration: 112.943645ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:00.495497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.330549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-18T19:44:00.495529Z","caller":"traceutil/trace.go:171","msg":"trace[225986623] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:501; }","duration":"126.402211ms","start":"2026-02-18T19:44:00.369116Z","end":"2026-02-18T19:44:00.495518Z","steps":["trace[225986623] 'agreement among raft nodes before linearized reading' (duration: 126.340999ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:00.495649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.554659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-18T19:44:00.495669Z","caller":"traceutil/trace.go:171","msg":"trace[1049156955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:501; }","duration":"111.583079ms","start":"2026-02-18T19:44:00.384081Z","end":"2026-02-18T19:44:00.495664Z","steps":["trace[1049156955] 'agreement among raft nodes before linearized reading' (duration: 111.534458ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:44:01.696085Z","caller":"traceutil/trace.go:171","msg":"trace[1274031036] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"160.85597ms","start":"2026-02-18T19:44:01.535205Z","end":"2026-02-18T19:44:01.696061Z","steps":["trace[1274031036] 'read index received' (duration: 160.628384ms)","trace[1274031036] 'applied index is now lower than readState.Index' (duration: 226.826µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:44:01.6963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.067035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-18T19:44:01.696322Z","caller":"traceutil/trace.go:171","msg":"trace[366731699] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:514; }","duration":"161.147197ms","start":"2026-02-18T19:44:01.535166Z","end":"2026-02-18T19:44:01.696314Z","steps":["trace[366731699] 'agreement among raft nodes before linearized reading' (duration: 160.981403ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:44:01.696509Z","caller":"traceutil/trace.go:171","msg":"trace[2084126420] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"209.69802ms","start":"2026-02-18T19:44:01.486779Z","end":"2026-02-18T19:44:01.696477Z","steps":["trace[2084126420] 'process raft request' (duration: 209.135776ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:04.759155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.30128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T19:44:04.759278Z","caller":"traceutil/trace.go:171","msg":"trace[1875346274] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:555; }","duration":"151.478324ms","start":"2026-02-18T19:44:04.607776Z","end":"2026-02-18T19:44:04.759254Z","steps":["trace[1875346274] 'agreement among raft nodes before linearized reading' (duration: 78.884094ms)","trace[1875346274] 'range keys from in-memory index tree' (duration: 72.408205ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:44:04.759668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.795382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-18T19:44:04.759828Z","caller":"traceutil/trace.go:171","msg":"trace[1200358607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:555; }","duration":"151.844494ms","start":"2026-02-18T19:44:04.607854Z","end":"2026-02-18T19:44:04.759699Z","steps":["trace[1200358607] 'agreement among raft nodes before linearized reading' (duration: 78.823264ms)","trace[1200358607] 'range keys from in-memory index tree' (duration: 72.844135ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:44:04.759788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.738885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"} {"level":"info","ts":"2026-02-18T19:44:04.759948Z","caller":"traceutil/trace.go:171","msg":"trace[1212426692] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:555; }","duration":"102.926341ms","start":"2026-02-18T19:44:04.657007Z","end":"2026-02-18T19:44:04.759933Z","steps":["trace[1212426692] 'agreement among raft nodes before linearized reading' (duration: 29.784607ms)","trace[1212426692] 'range keys from in-memory index tree' (duration: 72.783464ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:44:04.887611Z","caller":"traceutil/trace.go:171","msg":"trace[1050132061] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"113.948454ms","start":"2026-02-18T19:44:04.77364Z","end":"2026-02-18T19:44:04.887589Z","steps":["trace[1050132061] 'process raft request' (duration: 113.803471ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:44:04.933239Z","caller":"traceutil/trace.go:171","msg":"trace[1156965154] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"159.428562ms","start":"2026-02-18T19:44:04.773783Z","end":"2026-02-18T19:44:04.933211Z","steps":["trace[1156965154] 'process raft request' (duration: 158.378696ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:44:04.934832Z","caller":"traceutil/trace.go:171","msg":"trace[331764082] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"156.468848ms","start":"2026-02-18T19:44:04.778348Z","end":"2026-02-18T19:44:04.934817Z","steps":["trace[331764082] 'process raft request' (duration: 153.963756ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:44:10.295935Z","caller":"traceutil/trace.go:171","msg":"trace[2082682999] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"438.134745ms","start":"2026-02-18T19:44:09.857779Z","end":"2026-02-18T19:44:10.295914Z","steps":["trace[2082682999] 'read index received' (duration: 437.954271ms)","trace[2082682999] 'applied index is now lower than readState.Index' (duration: 179.794µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:44:10.296242Z","caller":"traceutil/trace.go:171","msg":"trace[1851650252] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"856.180599ms","start":"2026-02-18T19:44:09.440055Z","end":"2026-02-18T19:44:10.296235Z","steps":["trace[1851650252] 'process raft request' (duration: 855.739488ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:10.29633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:09.440036Z","time spent":"856.223389ms","remote":"127.0.0.1:51494","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-18T19:44:10.296689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.907853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-18T19:44:10.296711Z","caller":"traceutil/trace.go:171","msg":"trace[1097109752] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:576; }","duration":"438.952195ms","start":"2026-02-18T19:44:09.857751Z","end":"2026-02-18T19:44:10.296704Z","steps":["trace[1097109752] 'agreement among raft nodes before linearized reading' (duration: 438.837072ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:10.296671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.160517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-18T19:44:10.296789Z","caller":"traceutil/trace.go:171","msg":"trace[1456906912] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:576; }","duration":"330.346021ms","start":"2026-02-18T19:44:09.966407Z","end":"2026-02-18T19:44:10.296753Z","steps":["trace[1456906912] 'agreement among raft nodes before linearized reading' (duration: 330.026263ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:10.296843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:09.966382Z","time spent":"330.448134ms","remote":"127.0.0.1:51592","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-18T19:44:10.296729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:09.857734Z","time spent":"438.991255ms","remote":"127.0.0.1:51592","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-18T19:44:10.76878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.437957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:44:10.768857Z","caller":"traceutil/trace.go:171","msg":"trace[1525097730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"464.554091ms","start":"2026-02-18T19:44:10.304285Z","end":"2026-02-18T19:44:10.768839Z","steps":["trace[1525097730] 'range keys from in-memory index tree' (duration: 464.347965ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:10.768894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:10.304267Z","time spent":"464.620553ms","remote":"127.0.0.1:51310","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-18T19:44:10.839825Z","caller":"traceutil/trace.go:171","msg":"trace[1219890938] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"530.461396ms","start":"2026-02-18T19:44:10.309337Z","end":"2026-02-18T19:44:10.839799Z","steps":["trace[1219890938] 'process raft request' (duration: 530.326253ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:10.839998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:10.309324Z","time spent":"530.591339ms","remote":"127.0.0.1:51592","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-18T19:44:10.940768Z","caller":"traceutil/trace.go:171","msg":"trace[129966202] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"630.827313ms","start":"2026-02-18T19:44:10.309907Z","end":"2026-02-18T19:44:10.940734Z","steps":["trace[129966202] 'process raft request' (duration: 581.247543ms)","trace[129966202] 'compare' (duration: 49.174671ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:44:10.940915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:10.309901Z","time spent":"630.934286ms","remote":"127.0.0.1:51592","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-18T19:44:11.153588Z","caller":"traceutil/trace.go:171","msg":"trace[385478006] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"109.450971ms","start":"2026-02-18T19:44:11.04411Z","end":"2026-02-18T19:44:11.153561Z","steps":["trace[385478006] 'process raft request' (duration: 70.541601ms)","trace[385478006] 'compare' (duration: 38.765507ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:44:13.345921Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540751181842187,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T19:44:13.846636Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540751181842187,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T19:44:14.003839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.726737356s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:44:14.016932Z","caller":"traceutil/trace.go:171","msg":"trace[847788378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"1.739868867s","start":"2026-02-18T19:44:12.277045Z","end":"2026-02-18T19:44:14.016914Z","steps":["trace[847788378] 'range keys from in-memory index tree' (duration: 1.726675045s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:14.016982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:12.277026Z","time spent":"1.739941728s","remote":"127.0.0.1:51326","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-18T19:44:14.22143Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.484729479s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T19:44:14.221801Z","caller":"traceutil/trace.go:171","msg":"trace[240503733] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"1.485182669s","start":"2026-02-18T19:44:12.736595Z","end":"2026-02-18T19:44:14.221777Z","steps":["trace[240503733] 'process raft request' (duration: 1.485043515s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:14.2219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:12.736559Z","time spent":"1.485273561s","remote":"127.0.0.1:51592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:44:14.234772Z","caller":"traceutil/trace.go:171","msg":"trace[2088760592] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"1.389915322s","start":"2026-02-18T19:44:12.844842Z","end":"2026-02-18T19:44:14.234757Z","steps":["trace[2088760592] 'read index received' (duration: 1.377528728s)","trace[2088760592] 'applied index is now lower than readState.Index' (duration: 12.385664ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:44:14.234973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.390119766s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-18T19:44:14.235003Z","caller":"traceutil/trace.go:171","msg":"trace[1568498367] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:582; }","duration":"1.390197808s","start":"2026-02-18T19:44:12.844798Z","end":"2026-02-18T19:44:14.234996Z","steps":["trace[1568498367] 'agreement among raft nodes before linearized reading' (duration: 1.390045774s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:14.235028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:12.84478Z","time spent":"1.39024344s","remote":"127.0.0.1:51592","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-18T19:44:14.235195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.284054363s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-18T19:44:14.235214Z","caller":"traceutil/trace.go:171","msg":"trace[1018808611] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:582; }","duration":"1.284111665s","start":"2026-02-18T19:44:12.951096Z","end":"2026-02-18T19:44:14.235208Z","steps":["trace[1018808611] 'agreement among raft nodes before linearized reading' (duration: 1.284045353s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:14.235232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:12.951066Z","time spent":"1.284161165s","remote":"127.0.0.1:51592","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-18T19:44:14.235329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.657496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:44:14.235354Z","caller":"traceutil/trace.go:171","msg":"trace[383557867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"217.700368ms","start":"2026-02-18T19:44:14.017647Z","end":"2026-02-18T19:44:14.235347Z","steps":["trace[383557867] 'agreement among raft nodes before linearized reading' (duration: 217.668297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:14.235476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077762461s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T19:44:14.235495Z","caller":"traceutil/trace.go:171","msg":"trace[523988326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"1.077804322s","start":"2026-02-18T19:44:13.157685Z","end":"2026-02-18T19:44:14.23549Z","steps":["trace[523988326] 'agreement among raft nodes before linearized reading' (duration: 1.077751111s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:14.235508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:13.157666Z","time spent":"1.077837742s","remote":"127.0.0.1:51592","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-18T19:44:14.235592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.193257171s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-18T19:44:14.235612Z","caller":"traceutil/trace.go:171","msg":"trace[708461871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:582; }","duration":"1.193297293s","start":"2026-02-18T19:44:13.042307Z","end":"2026-02-18T19:44:14.235605Z","steps":["trace[708461871] 'agreement among raft nodes before linearized reading' (duration: 1.193249532s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:14.235624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:13.042297Z","time spent":"1.193325063s","remote":"127.0.0.1:51592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-18T19:44:14.235712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.220319896s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-18T19:44:14.23573Z","caller":"traceutil/trace.go:171","msg":"trace[721317736] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"1.220373926s","start":"2026-02-18T19:44:13.015351Z","end":"2026-02-18T19:44:14.235725Z","steps":["trace[721317736] 'agreement among raft nodes before linearized reading' (duration: 1.220326265s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:44:14.235744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:44:13.015324Z","time spent":"1.220416488s","remote":"127.0.0.1:51592","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-18T19:45:46.399257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.243627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:45:46.399347Z","caller":"traceutil/trace.go:171","msg":"trace[1949444259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:988; }","duration":"123.388168ms","start":"2026-02-18T19:45:46.275942Z","end":"2026-02-18T19:45:46.39933Z","steps":["trace[1949444259] 'range keys from in-memory index tree' (duration: 123.161125ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:45:47.137692Z","caller":"traceutil/trace.go:171","msg":"trace[874687334] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1030; }","duration":"244.581678ms","start":"2026-02-18T19:45:46.893093Z","end":"2026-02-18T19:45:47.137675Z","steps":["trace[874687334] 'read index received' (duration: 244.434586ms)","trace[874687334] 'applied index is now lower than readState.Index' (duration: 146.442µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:45:47.13797Z","caller":"traceutil/trace.go:171","msg":"trace[2011492653] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"247.579181ms","start":"2026-02-18T19:45:46.890382Z","end":"2026-02-18T19:45:47.137961Z","steps":["trace[2011492653] 'process raft request' (duration: 247.192436ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:45:47.138213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.107365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-18T19:45:47.138238Z","caller":"traceutil/trace.go:171","msg":"trace[2086440814] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:989; }","duration":"245.160167ms","start":"2026-02-18T19:45:46.893068Z","end":"2026-02-18T19:45:47.138229Z","steps":["trace[2086440814] 'agreement among raft nodes before linearized reading' (duration: 245.065786ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:45:47.138339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.305831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T19:45:47.138359Z","caller":"traceutil/trace.go:171","msg":"trace[61157066] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:989; }","duration":"189.345033ms","start":"2026-02-18T19:45:46.949006Z","end":"2026-02-18T19:45:47.138351Z","steps":["trace[61157066] 'agreement among raft nodes before linearized reading' (duration: 189.307492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:45:47.138709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.589657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T19:45:47.138735Z","caller":"traceutil/trace.go:171","msg":"trace[1183690996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:989; }","duration":"147.622818ms","start":"2026-02-18T19:45:46.991105Z","end":"2026-02-18T19:45:47.138728Z","steps":["trace[1183690996] 'agreement among raft nodes before linearized reading' (duration: 147.535287ms)"],"step_count":1}