{"level":"warn","ts":"2026-02-04T06:00:08.217586Z","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-04T06:00:08.217664Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.84: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.84:2380","--initial-cluster=instance=https://162.253.55.84:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.84:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.84: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-04T06:00:08.21773Z","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-04T06:00:08.217742Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.84:2380"]} {"level":"info","ts":"2026-02-04T06:00:08.217759Z","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-04T06:00:08.218321Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.84:2379"]} {"level":"info","ts":"2026-02-04T06:00:08.218388Z","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.84:2380"],"listen-peer-urls":["https://162.253.55.84:2380"],"advertise-client-urls":["https://162.253.55.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.84: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-04T06:00:08.22837Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.413586ms"} {"level":"info","ts":"2026-02-04T06:00:08.237435Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ca4c710a8d5349d7","cluster-id":"8e28a51debf1c8ab"} {"level":"info","ts":"2026-02-04T06:00:08.237566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 switched to configuration voters=()"} {"level":"info","ts":"2026-02-04T06:00:08.237627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became follower at term 0"} {"level":"info","ts":"2026-02-04T06:00:08.237705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ca4c710a8d5349d7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-04T06:00:08.237756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became follower at term 1"} {"level":"info","ts":"2026-02-04T06:00:08.238023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 switched to configuration voters=(14577150384026110423)"} {"level":"warn","ts":"2026-02-04T06:00:08.251538Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-04T06:00:08.257111Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-04T06:00:08.261131Z","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-04T06:00:08.272865Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ca4c710a8d5349d7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-04T06:00:08.273212Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ca4c710a8d5349d7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-04T06:00:08.273399Z","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-04T06:00:08.273542Z","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-04T06:00:08.27359Z","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-04T06:00:08.273851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 switched to configuration voters=(14577150384026110423)"} {"level":"info","ts":"2026-02-04T06:00:08.273985Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8e28a51debf1c8ab","local-member-id":"ca4c710a8d5349d7","added-peer-id":"ca4c710a8d5349d7","added-peer-peer-urls":["https://162.253.55.84:2380"]} {"level":"info","ts":"2026-02-04T06:00:08.286892Z","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-04T06:00:08.287047Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ca4c710a8d5349d7","initial-advertise-peer-urls":["https://162.253.55.84:2380"],"listen-peer-urls":["https://162.253.55.84:2380"],"advertise-client-urls":["https://162.253.55.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-04T06:00:08.28707Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-04T06:00:08.287148Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.84:2380"} {"level":"info","ts":"2026-02-04T06:00:08.28716Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.84:2380"} {"level":"info","ts":"2026-02-04T06:00:08.5425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 is starting a new election at term 1"} {"level":"info","ts":"2026-02-04T06:00:08.542563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-04T06:00:08.542594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 received MsgPreVoteResp from ca4c710a8d5349d7 at term 1"} {"level":"info","ts":"2026-02-04T06:00:08.542612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became candidate at term 2"} {"level":"info","ts":"2026-02-04T06:00:08.542623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 received MsgVoteResp from ca4c710a8d5349d7 at term 2"} {"level":"info","ts":"2026-02-04T06:00:08.542649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became leader at term 2"} {"level":"info","ts":"2026-02-04T06:00:08.542668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ca4c710a8d5349d7 elected leader ca4c710a8d5349d7 at term 2"} {"level":"info","ts":"2026-02-04T06:00:08.552758Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-04T06:00:08.554236Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ca4c710a8d5349d7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.84:2379]}","request-path":"/0/members/ca4c710a8d5349d7/attributes","cluster-id":"8e28a51debf1c8ab","publish-timeout":"7s"} {"level":"info","ts":"2026-02-04T06:00:08.55441Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-04T06:00:08.555911Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.84:2379"} {"level":"info","ts":"2026-02-04T06:00:08.563171Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-04T06:00:08.563192Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-04T06:00:08.558139Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8e28a51debf1c8ab","local-member-id":"ca4c710a8d5349d7","cluster-version":"3.5"} {"level":"info","ts":"2026-02-04T06:00:08.563481Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-04T06:00:08.563516Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-04T06:00:08.558173Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-04T06:00:08.566524Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-04T06:00:35.38354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.045709ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-04T06:00:35.383656Z","caller":"traceutil/trace.go:171","msg":"trace[1108464144] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"202.609366ms","start":"2026-02-04T06:00:35.18103Z","end":"2026-02-04T06:00:35.38364Z","steps":["trace[1108464144] 'process raft request' (duration: 97.869745ms)","trace[1108464144] 'compare' (duration: 103.659107ms)"],"step_count":2} {"level":"info","ts":"2026-02-04T06:00:35.384609Z","caller":"traceutil/trace.go:171","msg":"trace[827741111] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"202.995647ms","start":"2026-02-04T06:00:35.181604Z","end":"2026-02-04T06:00:35.3846Z","steps":["trace[827741111] 'process raft request' (duration: 202.737406ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:35.384931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.008474ms","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-04T06:00:35.384476Z","caller":"traceutil/trace.go:171","msg":"trace[1242759102] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:438; }","duration":"119.544183ms","start":"2026-02-04T06:00:35.264919Z","end":"2026-02-04T06:00:35.384463Z","steps":["trace[1242759102] 'read index received' (duration: 13.977969ms)","trace[1242759102] 'applied index is now lower than readState.Index' (duration: 105.565444ms)"],"step_count":2} {"level":"info","ts":"2026-02-04T06:00:35.385011Z","caller":"traceutil/trace.go:171","msg":"trace[922171546] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:0; response_revision:424; }","duration":"120.073544ms","start":"2026-02-04T06:00:35.26488Z","end":"2026-02-04T06:00:35.384954Z","steps":["trace[922171546] 'agreement among raft nodes before linearized reading' (duration: 120.019114ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T06:00:35.729609Z","caller":"traceutil/trace.go:171","msg":"trace[674037022] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"130.05174ms","start":"2026-02-04T06:00:35.59953Z","end":"2026-02-04T06:00:35.729581Z","steps":["trace[674037022] 'process raft request' (duration: 86.822197ms)","trace[674037022] 'compare' (duration: 42.959132ms)"],"step_count":2} {"level":"warn","ts":"2026-02-04T06:00:36.302538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.413789ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-04T06:00:36.304052Z","caller":"traceutil/trace.go:171","msg":"trace[443310155] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"486.693242ms","start":"2026-02-04T06:00:35.817336Z","end":"2026-02-04T06:00:36.304029Z","steps":["trace[443310155] 'process raft request' (duration: 171.721887ms)","trace[443310155] 'compare' (duration: 313.100818ms)"],"step_count":2} {"level":"warn","ts":"2026-02-04T06:00:36.30413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:35.817308Z","time spent":"486.788193ms","remote":"127.0.0.1:40030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-04T06:00:36.698352Z","caller":"traceutil/trace.go:171","msg":"trace[945864091] linearizableReadLoop","detail":"{readStateIndex:451; appliedIndex:450; }","duration":"228.363569ms","start":"2026-02-04T06:00:36.469967Z","end":"2026-02-04T06:00:36.69833Z","steps":["trace[945864091] 'read index received' (duration: 227.972868ms)","trace[945864091] 'applied index is now lower than readState.Index' (duration: 389.741µs)"],"step_count":2} {"level":"warn","ts":"2026-02-04T06:00:36.698847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.868311ms","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-04T06:00:36.698963Z","caller":"traceutil/trace.go:171","msg":"trace[1979197164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:435; }","duration":"229.027212ms","start":"2026-02-04T06:00:36.469922Z","end":"2026-02-04T06:00:36.698949Z","steps":["trace[1979197164] 'agreement among raft nodes before linearized reading' (duration: 228.839741ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T06:00:36.699278Z","caller":"traceutil/trace.go:171","msg":"trace[206468762] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"307.730618ms","start":"2026-02-04T06:00:36.391535Z","end":"2026-02-04T06:00:36.699266Z","steps":["trace[206468762] 'process raft request' (duration: 306.492443ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:36.703217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:36.391513Z","time spent":"311.646863ms","remote":"127.0.0.1:40192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14059,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-04T06:00:39.614261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.28211ms","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-04T06:00:39.614307Z","caller":"traceutil/trace.go:171","msg":"trace[1056868524] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:465; }","duration":"216.35551ms","start":"2026-02-04T06:00:39.39794Z","end":"2026-02-04T06:00:39.614296Z","steps":["trace[1056868524] 'range keys from in-memory index tree' (duration: 216.17571ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:39.614445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.500211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-04T06:00:39.614478Z","caller":"traceutil/trace.go:171","msg":"trace[351222661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:465; }","duration":"210.574651ms","start":"2026-02-04T06:00:39.403881Z","end":"2026-02-04T06:00:39.614455Z","steps":["trace[351222661] 'range keys from in-memory index tree' (duration: 210.142109ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:42.123504Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5320893177095729698,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-04T06:00:42.88009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.232329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-04T06:00:42.880158Z","caller":"traceutil/trace.go:171","msg":"trace[687429593] linearizableReadLoop","detail":"{readStateIndex:490; appliedIndex:489; }","duration":"1.256692826s","start":"2026-02-04T06:00:41.623454Z","end":"2026-02-04T06:00:42.880147Z","steps":["trace[687429593] 'read index received' (duration: 725.303727ms)","trace[687429593] 'applied index is now lower than readState.Index' (duration: 531.387969ms)"],"step_count":2} {"level":"info","ts":"2026-02-04T06:00:42.880276Z","caller":"traceutil/trace.go:171","msg":"trace[150982946] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"1.27016316s","start":"2026-02-04T06:00:41.610104Z","end":"2026-02-04T06:00:42.880267Z","steps":["trace[150982946] 'process raft request' (duration: 738.710171ms)","trace[150982946] 'compare' (duration: 530.777937ms)"],"step_count":2} {"level":"warn","ts":"2026-02-04T06:00:42.880309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:41.610094Z","time spent":"1.27019979s","remote":"127.0.0.1:39814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":389,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-04T06:00:42.880506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.257045087s","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-04T06:00:42.880527Z","caller":"traceutil/trace.go:171","msg":"trace[1600821423] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:472; }","duration":"1.257069077s","start":"2026-02-04T06:00:41.62345Z","end":"2026-02-04T06:00:42.880519Z","steps":["trace[1600821423] 'agreement among raft nodes before linearized reading' (duration: 1.256962947s)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:42.880548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:41.623384Z","time spent":"1.257159207s","remote":"127.0.0.1:39970","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-04T06:00:42.880671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.252826843s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-04T06:00:42.880691Z","caller":"traceutil/trace.go:171","msg":"trace[2137053916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:472; }","duration":"1.252871023s","start":"2026-02-04T06:00:41.627813Z","end":"2026-02-04T06:00:42.880684Z","steps":["trace[2137053916] 'agreement among raft nodes before linearized reading' (duration: 1.252817423s)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:42.880708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:41.627787Z","time spent":"1.252917053s","remote":"127.0.0.1:39970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-04T06:00:47.234538Z","caller":"traceutil/trace.go:171","msg":"trace[682171567] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"615.601609ms","start":"2026-02-04T06:00:46.618922Z","end":"2026-02-04T06:00:47.234524Z","steps":["trace[682171567] 'process raft request' (duration: 615.510969ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:47.234627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:46.618907Z","time spent":"615.673629ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-04T06:00:48.050767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:47.453119Z","time spent":"597.642352ms","remote":"127.0.0.1:44908","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-04T06:00:48.243931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.370679ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-04T06:00:48.244002Z","caller":"traceutil/trace.go:171","msg":"trace[1309911105] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:525; }","duration":"1.340162181s","start":"2026-02-04T06:00:46.903828Z","end":"2026-02-04T06:00:48.24399Z","steps":["trace[1309911105] 'read index received' (duration: 331.093093ms)","trace[1309911105] 'applied index is now lower than readState.Index' (duration: 1.009068288s)"],"step_count":2} {"level":"warn","ts":"2026-02-04T06:00:48.244137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.340304101s","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-04T06:00:48.244156Z","caller":"traceutil/trace.go:171","msg":"trace[993121362] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:507; }","duration":"1.340349762s","start":"2026-02-04T06:00:46.9038Z","end":"2026-02-04T06:00:48.24415Z","steps":["trace[993121362] 'agreement among raft nodes before linearized reading' (duration: 1.340248731s)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:48.244175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:46.903786Z","time spent":"1.340384772s","remote":"127.0.0.1:39970","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-04T06:00:48.244419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.231057ms","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-04T06:00:48.244438Z","caller":"traceutil/trace.go:171","msg":"trace[1329010619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:507; }","duration":"953.269667ms","start":"2026-02-04T06:00:47.291164Z","end":"2026-02-04T06:00:48.244433Z","steps":["trace[1329010619] 'agreement among raft nodes before linearized reading' (duration: 953.224187ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:48.24445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:47.291152Z","time spent":"953.295087ms","remote":"127.0.0.1:39970","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-04T06:00:48.24451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.98498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-04T06:00:48.244522Z","caller":"traceutil/trace.go:171","msg":"trace[798540937] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:507; }","duration":"382.0322ms","start":"2026-02-04T06:00:47.862486Z","end":"2026-02-04T06:00:48.244518Z","steps":["trace[798540937] 'agreement among raft nodes before linearized reading' (duration: 382.01286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:48.244502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.324766191s","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-04T06:00:48.244577Z","caller":"traceutil/trace.go:171","msg":"trace[75034913] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:507; }","duration":"1.324864301s","start":"2026-02-04T06:00:46.919688Z","end":"2026-02-04T06:00:48.244553Z","steps":["trace[75034913] 'agreement among raft nodes before linearized reading' (duration: 1.32464689s)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:48.244613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.323132375s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-04T06:00:48.244629Z","caller":"traceutil/trace.go:171","msg":"trace[1365033877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:507; }","duration":"1.323161745s","start":"2026-02-04T06:00:46.921463Z","end":"2026-02-04T06:00:48.244625Z","steps":["trace[1365033877] 'agreement among raft nodes before linearized reading' (duration: 1.323122725s)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:48.244621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:46.919677Z","time spent":"1.324935221s","remote":"127.0.0.1:39970","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-04T06:00:48.244642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:46.921457Z","time spent":"1.323182515s","remote":"127.0.0.1:39970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-04T06:00:48.244534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:47.862468Z","time spent":"382.06332ms","remote":"127.0.0.1:39702","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-04T06:00:49.88573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.217162ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-04T06:00:49.885902Z","caller":"traceutil/trace.go:171","msg":"trace[480393671] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:527; }","duration":"260.656443ms","start":"2026-02-04T06:00:49.62523Z","end":"2026-02-04T06:00:49.885887Z","steps":["trace[480393671] 'read index received' (duration: 28.13µs)","trace[480393671] 'applied index is now lower than readState.Index' (duration: 260.627473ms)"],"step_count":2} {"level":"info","ts":"2026-02-04T06:00:49.886092Z","caller":"traceutil/trace.go:171","msg":"trace[1984235906] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.636587394s","start":"2026-02-04T06:00:48.249493Z","end":"2026-02-04T06:00:49.88608Z","steps":["trace[1984235906] 'process raft request' (duration: 724.9653ms)","trace[1984235906] 'compare' (duration: 910.929321ms)"],"step_count":2} {"level":"warn","ts":"2026-02-04T06:00:49.886149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:48.249474Z","time spent":"1.636644804s","remote":"127.0.0.1:39970","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-04T06:00:49.886293Z","caller":"traceutil/trace.go:171","msg":"trace[127084720] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.636562314s","start":"2026-02-04T06:00:48.249722Z","end":"2026-02-04T06:00:49.886285Z","steps":["trace[127084720] 'process raft request' (duration: 1.636084883s)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:49.886341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:48.249707Z","time spent":"1.636607344s","remote":"127.0.0.1:39970","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-04T06:00:49.886521Z","caller":"traceutil/trace.go:171","msg":"trace[1988957244] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.631657978s","start":"2026-02-04T06:00:48.254847Z","end":"2026-02-04T06:00:49.886505Z","steps":["trace[1988957244] 'process raft request' (duration: 1.631008776s)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:49.886608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:48.254835Z","time spent":"1.631723628s","remote":"127.0.0.1:39970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-04T06:00:49.886666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.435075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-04T06:00:49.886685Z","caller":"traceutil/trace.go:171","msg":"trace[1271762924] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:511; }","duration":"261.483615ms","start":"2026-02-04T06:00:49.625196Z","end":"2026-02-04T06:00:49.886679Z","steps":["trace[1271762924] 'agreement among raft nodes before linearized reading' (duration: 261.456115ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:52.3437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.991326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-04T06:00:52.343754Z","caller":"traceutil/trace.go:171","msg":"trace[1950878561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:524; }","duration":"479.088876ms","start":"2026-02-04T06:00:51.864651Z","end":"2026-02-04T06:00:52.34374Z","steps":["trace[1950878561] 'range keys from in-memory index tree' (duration: 478.940726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:52.343777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:51.864638Z","time spent":"479.133597ms","remote":"127.0.0.1:39702","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-04T06:00:52.344501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.831371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-04T06:00:52.344526Z","caller":"traceutil/trace.go:171","msg":"trace[1396963456] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:524; }","duration":"451.862611ms","start":"2026-02-04T06:00:51.892656Z","end":"2026-02-04T06:00:52.344518Z","steps":["trace[1396963456] 'range keys from in-memory index tree' (duration: 451.204539ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:52.344543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:51.892653Z","time spent":"451.885931ms","remote":"127.0.0.1:39970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-04T06:00:52.344666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.028651ms","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-04T06:00:52.344682Z","caller":"traceutil/trace.go:171","msg":"trace[99131655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:524; }","duration":"452.083671ms","start":"2026-02-04T06:00:51.892593Z","end":"2026-02-04T06:00:52.344677Z","steps":["trace[99131655] 'range keys from in-memory index tree' (duration: 451.926621ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:52.344694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:51.892579Z","time spent":"452.111471ms","remote":"127.0.0.1:39970","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-04T06:00:52.344788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.878611ms","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-04T06:00:52.344821Z","caller":"traceutil/trace.go:171","msg":"trace[277317283] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:524; }","duration":"451.902551ms","start":"2026-02-04T06:00:51.892897Z","end":"2026-02-04T06:00:52.344799Z","steps":["trace[277317283] 'range keys from in-memory index tree' (duration: 451.827991ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:00:52.344835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:00:51.892891Z","time spent":"451.940711ms","remote":"127.0.0.1:39970","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-04T06:00:54.901716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.737448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-04T06:00:54.901787Z","caller":"traceutil/trace.go:171","msg":"trace[1354429069] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:582; }","duration":"108.837458ms","start":"2026-02-04T06:00:54.792932Z","end":"2026-02-04T06:00:54.90177Z","steps":["trace[1354429069] 'range keys from in-memory index tree' (duration: 108.615138ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:01:41.057891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.450912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-04T06:01:41.057975Z","caller":"traceutil/trace.go:171","msg":"trace[1286043281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:809; }","duration":"195.569906ms","start":"2026-02-04T06:01:40.862387Z","end":"2026-02-04T06:01:41.057957Z","steps":["trace[1286043281] 'range keys from in-memory index tree' (duration: 195.331097ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:02:17.263256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.028831ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-04T06:02:17.263363Z","caller":"traceutil/trace.go:171","msg":"trace[532470492] linearizableReadLoop","detail":"{readStateIndex:987; appliedIndex:986; }","duration":"308.707251ms","start":"2026-02-04T06:02:16.954639Z","end":"2026-02-04T06:02:17.263346Z","steps":["trace[532470492] 'read index received' (duration: 47.506696ms)","trace[532470492] 'applied index is now lower than readState.Index' (duration: 261.199085ms)"],"step_count":2} {"level":"warn","ts":"2026-02-04T06:02:17.263566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.915307ms","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-04T06:02:17.263594Z","caller":"traceutil/trace.go:171","msg":"trace[118939565] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:945; }","duration":"308.973179ms","start":"2026-02-04T06:02:16.954612Z","end":"2026-02-04T06:02:17.263585Z","steps":["trace[118939565] 'agreement among raft nodes before linearized reading' (duration: 308.833605ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:02:17.263626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:02:16.954599Z","time spent":"309.019599ms","remote":"127.0.0.1:39970","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-04T06:02:17.26388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.340353ms","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-04T06:02:17.263911Z","caller":"traceutil/trace.go:171","msg":"trace[1662019643] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:945; }","duration":"308.377343ms","start":"2026-02-04T06:02:16.955523Z","end":"2026-02-04T06:02:17.2639Z","steps":["trace[1662019643] 'agreement among raft nodes before linearized reading' (duration: 308.297261ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:02:17.263936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:02:16.955518Z","time spent":"308.412024ms","remote":"127.0.0.1:39970","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-04T06:02:17.264163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.029213ms","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-04T06:02:17.264191Z","caller":"traceutil/trace.go:171","msg":"trace[1629581491] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:945; }","duration":"199.070124ms","start":"2026-02-04T06:02:17.065112Z","end":"2026-02-04T06:02:17.264183Z","steps":["trace[1629581491] 'agreement among raft nodes before linearized reading' (duration: 198.993542ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:02:17.26435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.249759ms","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-04T06:02:17.26438Z","caller":"traceutil/trace.go:171","msg":"trace[460546091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:945; }","duration":"199.296359ms","start":"2026-02-04T06:02:17.065075Z","end":"2026-02-04T06:02:17.264371Z","steps":["trace[460546091] 'agreement among raft nodes before linearized reading' (duration: 199.222447ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:02:17.264819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.221173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-04T06:02:17.264874Z","caller":"traceutil/trace.go:171","msg":"trace[1726761784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:945; }","duration":"204.280145ms","start":"2026-02-04T06:02:17.06058Z","end":"2026-02-04T06:02:17.26486Z","steps":["trace[1726761784] 'agreement among raft nodes before linearized reading' (duration: 203.901665ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T06:02:17.89717Z","caller":"traceutil/trace.go:171","msg":"trace[1065035102] linearizableReadLoop","detail":"{readStateIndex:992; appliedIndex:988; }","duration":"205.630009ms","start":"2026-02-04T06:02:17.691523Z","end":"2026-02-04T06:02:17.897153Z","steps":["trace[1065035102] 'read index received' (duration: 205.410713ms)","trace[1065035102] 'applied index is now lower than readState.Index' (duration: 218.696µs)"],"step_count":2} {"level":"info","ts":"2026-02-04T06:02:17.898133Z","caller":"traceutil/trace.go:171","msg":"trace[2010762453] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"622.815165ms","start":"2026-02-04T06:02:17.275307Z","end":"2026-02-04T06:02:17.898122Z","steps":["trace[2010762453] 'process raft request' (duration: 621.678857ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:02:17.898249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:02:17.275303Z","time spent":"622.858576ms","remote":"127.0.0.1:39970","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-04T06:02:17.898563Z","caller":"traceutil/trace.go:171","msg":"trace[164241599] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"623.222885ms","start":"2026-02-04T06:02:17.275332Z","end":"2026-02-04T06:02:17.898555Z","steps":["trace[164241599] 'process raft request' (duration: 621.756298ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:02:17.898772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:02:17.275329Z","time spent":"623.257856ms","remote":"127.0.0.1:39970","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-04T06:02:17.89918Z","caller":"traceutil/trace.go:171","msg":"trace[1641368705] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"623.790629ms","start":"2026-02-04T06:02:17.275376Z","end":"2026-02-04T06:02:17.899166Z","steps":["trace[1641368705] 'process raft request' (duration: 621.738908ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:02:17.899382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:02:17.275372Z","time spent":"623.852701ms","remote":"127.0.0.1:39970","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-04T06:02:17.899801Z","caller":"traceutil/trace.go:171","msg":"trace[1489780518] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"624.391625ms","start":"2026-02-04T06:02:17.275396Z","end":"2026-02-04T06:02:17.899788Z","steps":["trace[1489780518] 'process raft request' (duration: 621.737568ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T06:02:17.900929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T06:02:17.275393Z","time spent":"625.472322ms","remote":"127.0.0.1:39970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-04T06:02:17.900144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.591003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-04T06:02:17.90159Z","caller":"traceutil/trace.go:171","msg":"trace[2030415125] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:950; }","duration":"210.087791ms","start":"2026-02-04T06:02:17.691484Z","end":"2026-02-04T06:02:17.901572Z","steps":["trace[2030415125] 'agreement among raft nodes before linearized reading' (duration: 208.569073ms)"],"step_count":1}