{"level":"warn","ts":"2026-01-29T15:39:48.245364Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-29T15:39:48.245635Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.200: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.200:2380","--initial-cluster=instance=https://162.253.55.200:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.200:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.200: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-01-29T15:39:48.245794Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-29T15:39:48.245853Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.200:2380"]}
{"level":"info","ts":"2026-01-29T15:39:48.246012Z","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-01-29T15:39:48.246755Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"]}
{"level":"info","ts":"2026-01-29T15:39:48.248336Z","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.200:2380"],"listen-peer-urls":["https://162.253.55.200:2380"],"advertise-client-urls":["https://162.253.55.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.200: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-01-29T15:39:48.253225Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.579661ms"}
{"level":"info","ts":"2026-01-29T15:39:48.265976Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e10bb51ed7578852","cluster-id":"aa14459abd2161c3"}
{"level":"info","ts":"2026-01-29T15:39:48.26604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=()"}
{"level":"info","ts":"2026-01-29T15:39:48.266059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became follower at term 0"}
{"level":"info","ts":"2026-01-29T15:39:48.26607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e10bb51ed7578852 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-29T15:39:48.266078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became follower at term 1"}
{"level":"info","ts":"2026-01-29T15:39:48.266106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=(16216254027344087122)"}
{"level":"warn","ts":"2026-01-29T15:39:48.275524Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-29T15:39:48.279018Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-29T15:39:48.28298Z","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-01-29T15:39:48.291344Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e10bb51ed7578852","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-29T15:39:48.292153Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e10bb51ed7578852","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-29T15:39:48.292401Z","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-01-29T15:39:48.292487Z","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-01-29T15:39:48.293349Z","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-01-29T15:39:48.293297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=(16216254027344087122)"}
{"level":"info","ts":"2026-01-29T15:39:48.293482Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aa14459abd2161c3","local-member-id":"e10bb51ed7578852","added-peer-id":"e10bb51ed7578852","added-peer-peer-urls":["https://162.253.55.200:2380"]}
{"level":"info","ts":"2026-01-29T15:39:48.32168Z","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-01-29T15:39:48.322546Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e10bb51ed7578852","initial-advertise-peer-urls":["https://162.253.55.200:2380"],"listen-peer-urls":["https://162.253.55.200:2380"],"advertise-client-urls":["https://162.253.55.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-29T15:39:48.322574Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-29T15:39:48.32281Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.200:2380"}
{"level":"info","ts":"2026-01-29T15:39:48.322821Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.200:2380"}
{"level":"info","ts":"2026-01-29T15:39:48.668347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 is starting a new election at term 1"}
{"level":"info","ts":"2026-01-29T15:39:48.668522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-29T15:39:48.668598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 received MsgPreVoteResp from e10bb51ed7578852 at term 1"}
{"level":"info","ts":"2026-01-29T15:39:48.668655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became candidate at term 2"}
{"level":"info","ts":"2026-01-29T15:39:48.668711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 received MsgVoteResp from e10bb51ed7578852 at term 2"}
{"level":"info","ts":"2026-01-29T15:39:48.66875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became leader at term 2"}
{"level":"info","ts":"2026-01-29T15:39:48.66883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e10bb51ed7578852 elected leader e10bb51ed7578852 at term 2"}
{"level":"info","ts":"2026-01-29T15:39:48.672793Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e10bb51ed7578852","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.200:2379]}","request-path":"/0/members/e10bb51ed7578852/attributes","cluster-id":"aa14459abd2161c3","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-29T15:39:48.672838Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-29T15:39:48.672933Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T15:39:48.675076Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-29T15:39:48.675161Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-29T15:39:48.676818Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.200:2379"}
{"level":"info","ts":"2026-01-29T15:39:48.672963Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-29T15:39:48.684761Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aa14459abd2161c3","local-member-id":"e10bb51ed7578852","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T15:39:48.685094Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T15:39:48.685147Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T15:39:48.693669Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-01-29T15:40:08.814394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.282724ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823085305775959519 > lease_revoke:<id:08529c0a6922ac24>","response":"size:29"}
{"level":"info","ts":"2026-01-29T15:40:08.81452Z","caller":"traceutil/trace.go:171","msg":"trace[595133073] linearizableReadLoop","detail":"{readStateIndex:472; appliedIndex:471; }","duration":"694.698135ms","start":"2026-01-29T15:40:08.119809Z","end":"2026-01-29T15:40:08.814507Z","steps":["trace[595133073] 'read index received'  (duration: 209.151666ms)","trace[595133073] 'applied index is now lower than readState.Index'  (duration: 485.545489ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:40:08.814624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.807028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-01-29T15:40:08.814643Z","caller":"traceutil/trace.go:171","msg":"trace[784950664] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:459; }","duration":"694.865188ms","start":"2026-01-29T15:40:08.11977Z","end":"2026-01-29T15:40:08.814635Z","steps":["trace[784950664] 'agreement among raft nodes before linearized reading'  (duration: 694.809407ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:08.814666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:08.119752Z","time spent":"694.90836ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-29T15:40:08.814843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.095894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:40:08.81486Z","caller":"traceutil/trace.go:171","msg":"trace[462907266] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:459; }","duration":"521.133804ms","start":"2026-01-29T15:40:08.293721Z","end":"2026-01-29T15:40:08.814855Z","steps":["trace[462907266] 'agreement among raft nodes before linearized reading'  (duration: 521.108674ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:08.814876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:08.29371Z","time spent":"521.162944ms","remote":"127.0.0.1:58930","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-01-29T15:40:08.814997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.458532ms","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-01-29T15:40:08.815044Z","caller":"traceutil/trace.go:171","msg":"trace[1623457324] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:459; }","duration":"371.530964ms","start":"2026-01-29T15:40:08.443509Z","end":"2026-01-29T15:40:08.815039Z","steps":["trace[1623457324] 'agreement among raft nodes before linearized reading'  (duration: 371.469993ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:08.815061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:08.443494Z","time spent":"371.562715ms","remote":"127.0.0.1:59188","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":"info","ts":"2026-01-29T15:40:19.004805Z","caller":"traceutil/trace.go:171","msg":"trace[193122986] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"130.575041ms","start":"2026-01-29T15:40:18.87421Z","end":"2026-01-29T15:40:19.004785Z","steps":["trace[193122986] 'process raft request'  (duration: 130.478718ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:40:19.00698Z","caller":"traceutil/trace.go:171","msg":"trace[1600477510] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"131.075981ms","start":"2026-01-29T15:40:18.875896Z","end":"2026-01-29T15:40:19.006971Z","steps":["trace[1600477510] 'process raft request'  (duration: 131.03726ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:19.411769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.48747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:40:19.411828Z","caller":"traceutil/trace.go:171","msg":"trace[1994456344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:522; }","duration":"119.637873ms","start":"2026-01-29T15:40:19.292178Z","end":"2026-01-29T15:40:19.411816Z","steps":["trace[1994456344] 'range keys from in-memory index tree'  (duration: 119.437949ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:40:21.925616Z","caller":"traceutil/trace.go:171","msg":"trace[1920976064] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"346.772143ms","start":"2026-01-29T15:40:21.57882Z","end":"2026-01-29T15:40:21.925592Z","steps":["trace[1920976064] 'process raft request'  (duration: 346.62451ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:21.926169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:21.578805Z","time spent":"346.899326ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:468 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-01-29T15:40:24.836805Z","caller":"traceutil/trace.go:171","msg":"trace[1459992830] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"435.355246ms","start":"2026-01-29T15:40:24.401427Z","end":"2026-01-29T15:40:24.836782Z","steps":["trace[1459992830] 'process raft request'  (duration: 435.228453ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:24.836952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:24.40141Z","time spent":"435.465909ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:474 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-01-29T15:40:25.158846Z","caller":"traceutil/trace.go:171","msg":"trace[30147844] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"128.661718ms","start":"2026-01-29T15:40:25.030166Z","end":"2026-01-29T15:40:25.158828Z","steps":["trace[30147844] 'process raft request'  (duration: 128.553925ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:40:25.329909Z","caller":"traceutil/trace.go:171","msg":"trace[1362823608] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:550; }","duration":"228.228027ms","start":"2026-01-29T15:40:25.101658Z","end":"2026-01-29T15:40:25.329886Z","steps":["trace[1362823608] 'read index received'  (duration: 57.349687ms)","trace[1362823608] 'applied index is now lower than readState.Index'  (duration: 170.87747ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T15:40:25.330027Z","caller":"traceutil/trace.go:171","msg":"trace[39308450] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"299.753053ms","start":"2026-01-29T15:40:25.030263Z","end":"2026-01-29T15:40:25.330016Z","steps":["trace[39308450] 'process raft request'  (duration: 257.229312ms)","trace[39308450] 'compare'  (duration: 42.289656ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:40:25.330156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.44658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-01-29T15:40:25.330269Z","caller":"traceutil/trace.go:171","msg":"trace[1215130202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:535; }","duration":"220.535303ms","start":"2026-01-29T15:40:25.109666Z","end":"2026-01-29T15:40:25.330202Z","steps":["trace[1215130202] 'agreement among raft nodes before linearized reading'  (duration: 220.432911ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:25.330433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.757219ms","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-01-29T15:40:25.330471Z","caller":"traceutil/trace.go:171","msg":"trace[1491645606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:535; }","duration":"228.83595ms","start":"2026-01-29T15:40:25.101624Z","end":"2026-01-29T15:40:25.33046Z","steps":["trace[1491645606] 'agreement among raft nodes before linearized reading'  (duration: 228.751778ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:28.432564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.367473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-47nsg\" ","response":"range_response_count:1 size:16916"}
{"level":"info","ts":"2026-01-29T15:40:28.432615Z","caller":"traceutil/trace.go:171","msg":"trace[1319537767] range","detail":"{range_begin:/registry/pods/kube-system/cilium-47nsg; range_end:; response_count:1; response_revision:550; }","duration":"164.451845ms","start":"2026-01-29T15:40:28.268151Z","end":"2026-01-29T15:40:28.432602Z","steps":["trace[1319537767] 'range keys from in-memory index tree'  (duration: 164.247941ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:40:28.433103Z","caller":"traceutil/trace.go:171","msg":"trace[181408752] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:567; }","duration":"139.495061ms","start":"2026-01-29T15:40:28.2936Z","end":"2026-01-29T15:40:28.433095Z","steps":["trace[181408752] 'read index received'  (duration: 112.953701ms)","trace[181408752] 'applied index is now lower than readState.Index'  (duration: 26.54058ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T15:40:28.433152Z","caller":"traceutil/trace.go:171","msg":"trace[1150332778] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"162.512462ms","start":"2026-01-29T15:40:28.270632Z","end":"2026-01-29T15:40:28.433145Z","steps":["trace[1150332778] 'process raft request'  (duration: 135.978283ms)","trace[1150332778] 'compare'  (duration: 24.79459ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:40:28.433355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.766897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:40:28.433396Z","caller":"traceutil/trace.go:171","msg":"trace[1822450231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:551; }","duration":"139.825879ms","start":"2026-01-29T15:40:28.293564Z","end":"2026-01-29T15:40:28.43339Z","steps":["trace[1822450231] 'agreement among raft nodes before linearized reading'  (duration: 139.565252ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:40:41.504021Z","caller":"traceutil/trace.go:171","msg":"trace[1900739398] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"722.095003ms","start":"2026-01-29T15:40:40.781912Z","end":"2026-01-29T15:40:41.504007Z","steps":["trace[1900739398] 'process raft request'  (duration: 721.966161ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:40:41.504124Z","caller":"traceutil/trace.go:171","msg":"trace[1289128694] linearizableReadLoop","detail":"{readStateIndex:733; appliedIndex:733; }","duration":"281.783415ms","start":"2026-01-29T15:40:41.222317Z","end":"2026-01-29T15:40:41.504101Z","steps":["trace[1289128694] 'read index received'  (duration: 281.780585ms)","trace[1289128694] 'applied index is now lower than readState.Index'  (duration: 2.38µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:40:41.504233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.910998ms","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-01-29T15:40:41.504253Z","caller":"traceutil/trace.go:171","msg":"trace[197035840] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:713; }","duration":"281.95851ms","start":"2026-01-29T15:40:41.222288Z","end":"2026-01-29T15:40:41.504247Z","steps":["trace[197035840] 'agreement among raft nodes before linearized reading'  (duration: 281.862718ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:41.504552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:40.781903Z","time spent":"722.163115ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:667 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-29T15:40:42.395367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.191668ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823085305775960015 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/coredns-5dd5756b68-27b7t.188f3de71924d930\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-5dd5756b68-27b7t.188f3de71924d930\" value_size:635 lease:599713268921182913 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-01-29T15:40:42.396272Z","caller":"traceutil/trace.go:171","msg":"trace[612234836] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:733; }","duration":"892.109606ms","start":"2026-01-29T15:40:41.50414Z","end":"2026-01-29T15:40:42.39625Z","steps":["trace[612234836] 'read index received'  (duration: 472.990357ms)","trace[612234836] 'applied index is now lower than readState.Index'  (duration: 419.117489ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T15:40:42.396337Z","caller":"traceutil/trace.go:171","msg":"trace[863401700] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"1.045374447s","start":"2026-01-29T15:40:41.350954Z","end":"2026-01-29T15:40:42.396328Z","steps":["trace[863401700] 'process raft request'  (duration: 626.165096ms)","trace[863401700] 'compare'  (duration: 417.930892ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:40:42.396412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:41.350945Z","time spent":"1.045412388s","remote":"127.0.0.1:58994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":723,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/coredns-5dd5756b68-27b7t.188f3de71924d930\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-5dd5756b68-27b7t.188f3de71924d930\" value_size:635 lease:599713268921182913 >> failure:<>"}
{"level":"warn","ts":"2026-01-29T15:40:42.396743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"898.267494ms","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-01-29T15:40:42.396773Z","caller":"traceutil/trace.go:171","msg":"trace[444567775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:714; }","duration":"898.325005ms","start":"2026-01-29T15:40:41.498439Z","end":"2026-01-29T15:40:42.396764Z","steps":["trace[444567775] 'agreement among raft nodes before linearized reading'  (duration: 898.175332ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:42.396797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:41.498428Z","time spent":"898.363907ms","remote":"127.0.0.1:59188","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-01-29T15:40:42.396976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.514737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-01-29T15:40:42.397003Z","caller":"traceutil/trace.go:171","msg":"trace[1563677465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:714; }","duration":"955.583168ms","start":"2026-01-29T15:40:41.441412Z","end":"2026-01-29T15:40:42.396995Z","steps":["trace[1563677465] 'agreement among raft nodes before linearized reading'  (duration: 955.488816ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:42.397025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:41.4414Z","time spent":"955.61957ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-29T15:40:42.397177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.04725505s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-27b7t\" ","response":"range_response_count:1 size:4824"}
{"level":"info","ts":"2026-01-29T15:40:42.397231Z","caller":"traceutil/trace.go:171","msg":"trace[2087025334] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-27b7t; range_end:; response_count:1; response_revision:714; }","duration":"1.047344962s","start":"2026-01-29T15:40:41.349878Z","end":"2026-01-29T15:40:42.397223Z","steps":["trace[2087025334] 'agreement among raft nodes before linearized reading'  (duration: 1.04724399s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:42.397255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:41.349863Z","time spent":"1.047385383s","remote":"127.0.0.1:59090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4848,"request content":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-27b7t\" "}
{"level":"warn","ts":"2026-01-29T15:40:42.397427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.1039219s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:40:42.397455Z","caller":"traceutil/trace.go:171","msg":"trace[1018575553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:714; }","duration":"1.103964681s","start":"2026-01-29T15:40:41.293481Z","end":"2026-01-29T15:40:42.397446Z","steps":["trace[1018575553] 'agreement among raft nodes before linearized reading'  (duration: 1.10392076s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:42.397474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:41.293472Z","time spent":"1.103997262s","remote":"127.0.0.1:58930","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-01-29T15:40:42.419499Z","caller":"traceutil/trace.go:171","msg":"trace[130309866] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"913.056388ms","start":"2026-01-29T15:40:41.506431Z","end":"2026-01-29T15:40:42.419487Z","steps":["trace[130309866] 'process raft request'  (duration: 912.985957ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:42.41958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:41.506423Z","time spent":"913.111319ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:675 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-01-29T15:40:42.457502Z","caller":"traceutil/trace.go:171","msg":"trace[715991826] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"447.728605ms","start":"2026-01-29T15:40:42.009749Z","end":"2026-01-29T15:40:42.457477Z","steps":["trace[715991826] 'process raft request'  (duration: 446.63937ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:42.457622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:42.009733Z","time spent":"447.824808ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:611 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-01-29T15:40:42.45785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.664927ms","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-01-29T15:40:42.457881Z","caller":"traceutil/trace.go:171","msg":"trace[910317362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:718; }","duration":"942.707699ms","start":"2026-01-29T15:40:41.515164Z","end":"2026-01-29T15:40:42.457872Z","steps":["trace[910317362] 'agreement among raft nodes before linearized reading'  (duration: 942.598656ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:42.457909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:41.515157Z","time spent":"942.74569ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-01-29T15:40:42.886056Z","caller":"traceutil/trace.go:171","msg":"trace[1257626929] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"393.115932ms","start":"2026-01-29T15:40:42.492919Z","end":"2026-01-29T15:40:42.886035Z","steps":["trace[1257626929] 'process raft request'  (duration: 393.057161ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:42.886187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:42.492912Z","time spent":"393.204624ms","remote":"127.0.0.1:58972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.200\" mod_revision:617 > success:<request_put:<key:\"/registry/masterleases/162.253.55.200\" value_size:67 lease:599713268921184216 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.200\" > >"}
{"level":"info","ts":"2026-01-29T15:40:42.886515Z","caller":"traceutil/trace.go:171","msg":"trace[322244878] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"418.620048ms","start":"2026-01-29T15:40:42.467881Z","end":"2026-01-29T15:40:42.886501Z","steps":["trace[322244878] 'process raft request'  (duration: 356.473364ms)","trace[322244878] 'compare'  (duration: 61.061709ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:40:42.88658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:42.467868Z","time spent":"418.67588ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:696 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-01-29T15:40:42.886711Z","caller":"traceutil/trace.go:171","msg":"trace[1854775585] linearizableReadLoop","detail":"{readStateIndex:740; appliedIndex:739; }","duration":"417.345079ms","start":"2026-01-29T15:40:42.469356Z","end":"2026-01-29T15:40:42.886701Z","steps":["trace[1854775585] 'read index received'  (duration: 23.276496ms)","trace[1854775585] 'applied index is now lower than readState.Index'  (duration: 394.067473ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:40:42.886795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.433791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:40:42.886825Z","caller":"traceutil/trace.go:171","msg":"trace[1187978382] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:720; }","duration":"417.478572ms","start":"2026-01-29T15:40:42.469337Z","end":"2026-01-29T15:40:42.886816Z","steps":["trace[1187978382] 'agreement among raft nodes before linearized reading'  (duration: 417.39774ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:42.886853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:42.469332Z","time spent":"417.513922ms","remote":"127.0.0.1:58930","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-01-29T15:40:46.862909Z","caller":"traceutil/trace.go:171","msg":"trace[1421910661] linearizableReadLoop","detail":"{readStateIndex:750; appliedIndex:749; }","duration":"388.907447ms","start":"2026-01-29T15:40:46.473953Z","end":"2026-01-29T15:40:46.862861Z","steps":["trace[1421910661] 'read index received'  (duration: 388.713912ms)","trace[1421910661] 'applied index is now lower than readState.Index'  (duration: 192.795µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T15:40:46.863061Z","caller":"traceutil/trace.go:171","msg":"trace[2144403399] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"427.12903ms","start":"2026-01-29T15:40:46.435918Z","end":"2026-01-29T15:40:46.863047Z","steps":["trace[2144403399] 'process raft request'  (duration: 426.810063ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:46.863187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:46.435879Z","time spent":"427.209392ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:722 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-01-29T15:40:46.863192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.516717ms","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-01-29T15:40:46.863236Z","caller":"traceutil/trace.go:171","msg":"trace[1589619649] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:729; }","duration":"388.580279ms","start":"2026-01-29T15:40:46.474644Z","end":"2026-01-29T15:40:46.863224Z","steps":["trace[1589619649] 'agreement among raft nodes before linearized reading'  (duration: 388.469426ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:46.863263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:46.474627Z","time spent":"388.627569ms","remote":"127.0.0.1:59188","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-01-29T15:40:46.863343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.412938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-01-29T15:40:46.863355Z","caller":"traceutil/trace.go:171","msg":"trace[1109827780] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:729; }","duration":"389.438928ms","start":"2026-01-29T15:40:46.473912Z","end":"2026-01-29T15:40:46.863351Z","steps":["trace[1109827780] 'agreement among raft nodes before linearized reading'  (duration: 389.404718ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:46.863366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:46.473905Z","time spent":"389.458859ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-29T15:40:46.863419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.115849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:40:46.863436Z","caller":"traceutil/trace.go:171","msg":"trace[1942457308] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:729; }","duration":"211.15951ms","start":"2026-01-29T15:40:46.652273Z","end":"2026-01-29T15:40:46.863432Z","steps":["trace[1942457308] 'agreement among raft nodes before linearized reading'  (duration: 211.13691ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:40:46.973665Z","caller":"traceutil/trace.go:171","msg":"trace[1287429462] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"104.497211ms","start":"2026-01-29T15:40:46.869153Z","end":"2026-01-29T15:40:46.97365Z","steps":["trace[1287429462] 'process raft request'  (duration: 90.186118ms)","trace[1287429462] 'compare'  (duration: 14.094858ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T15:40:53.218038Z","caller":"traceutil/trace.go:171","msg":"trace[1661545891] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"330.747052ms","start":"2026-01-29T15:40:52.887275Z","end":"2026-01-29T15:40:53.218022Z","steps":["trace[1661545891] 'process raft request'  (duration: 330.65554ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:53.218149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:52.887263Z","time spent":"330.835334ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:744 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-01-29T15:40:53.218438Z","caller":"traceutil/trace.go:171","msg":"trace[1285219023] linearizableReadLoop","detail":"{readStateIndex:774; appliedIndex:774; }","duration":"330.347043ms","start":"2026-01-29T15:40:52.888086Z","end":"2026-01-29T15:40:53.218433Z","steps":["trace[1285219023] 'read index received'  (duration: 330.344973ms)","trace[1285219023] 'applied index is now lower than readState.Index'  (duration: 1.77µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:40:53.218513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.431865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-01-29T15:40:53.218527Z","caller":"traceutil/trace.go:171","msg":"trace[463163254] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:751; }","duration":"330.477306ms","start":"2026-01-29T15:40:52.888045Z","end":"2026-01-29T15:40:53.218522Z","steps":["trace[463163254] 'agreement among raft nodes before linearized reading'  (duration: 330.416665ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:53.21854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:40:52.888029Z","time spent":"330.507767ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-29T15:40:53.218635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.52026ms","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-01-29T15:40:53.218647Z","caller":"traceutil/trace.go:171","msg":"trace[149631982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:751; }","duration":"227.561001ms","start":"2026-01-29T15:40:52.991083Z","end":"2026-01-29T15:40:53.218644Z","steps":["trace[149631982] 'agreement among raft nodes before linearized reading'  (duration: 227.52448ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:40:53.218732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.607518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-01-29T15:40:53.218743Z","caller":"traceutil/trace.go:171","msg":"trace[963940790] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:751; }","duration":"206.647599ms","start":"2026-01-29T15:40:53.012092Z","end":"2026-01-29T15:40:53.21874Z","steps":["trace[963940790] 'agreement among raft nodes before linearized reading'  (duration: 206.614329ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:06.313902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.167161ms","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-01-29T15:41:06.313976Z","caller":"traceutil/trace.go:171","msg":"trace[1569024781] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:788; }","duration":"689.305125ms","start":"2026-01-29T15:41:05.624654Z","end":"2026-01-29T15:41:06.313959Z","steps":["trace[1569024781] 'range keys from in-memory index tree'  (duration: 688.957097ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:06.314014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:05.624634Z","time spent":"689.371697ms","remote":"127.0.0.1:59188","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":"info","ts":"2026-01-29T15:41:06.351813Z","caller":"traceutil/trace.go:171","msg":"trace[1194495449] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"381.966125ms","start":"2026-01-29T15:41:05.969534Z","end":"2026-01-29T15:41:06.3515Z","steps":["trace[1194495449] 'process raft request'  (duration: 381.792802ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:06.354212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:05.969345Z","time spent":"384.726909ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:762 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-01-29T15:41:07.489845Z","caller":"traceutil/trace.go:171","msg":"trace[1183331754] linearizableReadLoop","detail":"{readStateIndex:816; appliedIndex:815; }","duration":"192.660781ms","start":"2026-01-29T15:41:07.297161Z","end":"2026-01-29T15:41:07.489822Z","steps":["trace[1183331754] 'read index received'  (duration: 192.485977ms)","trace[1183331754] 'applied index is now lower than readState.Index'  (duration: 173.784µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:41:07.490152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.978499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:41:07.49026Z","caller":"traceutil/trace.go:171","msg":"trace[267619094] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:791; }","duration":"193.138393ms","start":"2026-01-29T15:41:07.297109Z","end":"2026-01-29T15:41:07.490247Z","steps":["trace[267619094] 'agreement among raft nodes before linearized reading'  (duration: 192.894086ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:41:07.490513Z","caller":"traceutil/trace.go:171","msg":"trace[567549314] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"228.350412ms","start":"2026-01-29T15:41:07.262151Z","end":"2026-01-29T15:41:07.490502Z","steps":["trace[567549314] 'process raft request'  (duration: 227.554143ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:07.491035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.99115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-01-29T15:41:07.491082Z","caller":"traceutil/trace.go:171","msg":"trace[1551180858] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:791; }","duration":"187.049612ms","start":"2026-01-29T15:41:07.304019Z","end":"2026-01-29T15:41:07.491069Z","steps":["trace[1551180858] 'agreement among raft nodes before linearized reading'  (duration: 186.922219ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:07.491263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.233775ms","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-01-29T15:41:07.49129Z","caller":"traceutil/trace.go:171","msg":"trace[1261969312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:791; }","duration":"141.261266ms","start":"2026-01-29T15:41:07.350021Z","end":"2026-01-29T15:41:07.491282Z","steps":["trace[1261969312] 'agreement among raft nodes before linearized reading'  (duration: 141.185794ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:07.491443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.89294ms","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-01-29T15:41:07.491469Z","caller":"traceutil/trace.go:171","msg":"trace[81487013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:791; }","duration":"147.937411ms","start":"2026-01-29T15:41:07.343524Z","end":"2026-01-29T15:41:07.491461Z","steps":["trace[81487013] 'agreement among raft nodes before linearized reading'  (duration: 147.864109ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:08.276855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.891896ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823085305775960229 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:788 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T15:41:08.277426Z","caller":"traceutil/trace.go:171","msg":"trace[208941524] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"777.878366ms","start":"2026-01-29T15:41:07.499506Z","end":"2026-01-29T15:41:08.277384Z","steps":["trace[208941524] 'process raft request'  (duration: 425.371946ms)","trace[208941524] 'compare'  (duration: 351.793423ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:41:08.277574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:07.4995Z","time spent":"777.995839ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:788 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-01-29T15:41:08.277942Z","caller":"traceutil/trace.go:171","msg":"trace[1287968645] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"777.400135ms","start":"2026-01-29T15:41:07.500527Z","end":"2026-01-29T15:41:08.277927Z","steps":["trace[1287968645] 'process raft request'  (duration: 776.410111ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:08.278011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:07.500521Z","time spent":"777.458416ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:787 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-01-29T15:41:08.278232Z","caller":"traceutil/trace.go:171","msg":"trace[1453630208] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:817; }","duration":"570.093332ms","start":"2026-01-29T15:41:07.708127Z","end":"2026-01-29T15:41:08.27822Z","steps":["trace[1453630208] 'read index received'  (duration: 216.890986ms)","trace[1453630208] 'applied index is now lower than readState.Index'  (duration: 353.201036ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:41:08.857415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.409002ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823085305775960231 > lease_revoke:<id:08529c0a6922b027>","response":"size:29"}
{"level":"info","ts":"2026-01-29T15:41:08.857519Z","caller":"traceutil/trace.go:171","msg":"trace[1640719394] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"561.628436ms","start":"2026-01-29T15:41:08.295869Z","end":"2026-01-29T15:41:08.857498Z","steps":["trace[1640719394] 'read index received'  (duration: 34.031µs)","trace[1640719394] 'applied index is now lower than readState.Index'  (duration: 561.592884ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:41:08.857741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.149620994s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-29T15:41:08.857797Z","caller":"traceutil/trace.go:171","msg":"trace[1538377680] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:794; }","duration":"1.149728226s","start":"2026-01-29T15:41:07.708053Z","end":"2026-01-29T15:41:08.857782Z","steps":["trace[1538377680] 'agreement among raft nodes before linearized reading'  (duration: 570.204355ms)","trace[1538377680] 'count revisions from in-memory index tree'  (duration: 579.437589ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:41:08.857827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:07.708033Z","time spent":"1.149787517s","remote":"127.0.0.1:59016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":4,"response size":31,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T15:41:08.857924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.050135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:41:08.857956Z","caller":"traceutil/trace.go:171","msg":"trace[1301864223] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"562.118357ms","start":"2026-01-29T15:41:08.295828Z","end":"2026-01-29T15:41:08.857946Z","steps":["trace[1301864223] 'agreement among raft nodes before linearized reading'  (duration: 562.053555ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:08.857986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:08.295812Z","time spent":"562.167108ms","remote":"127.0.0.1:58930","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-01-29T15:41:08.85815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.350116ms","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-01-29T15:41:08.858173Z","caller":"traceutil/trace.go:171","msg":"trace[1295453839] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:794; }","duration":"444.401668ms","start":"2026-01-29T15:41:08.413765Z","end":"2026-01-29T15:41:08.858166Z","steps":["trace[1295453839] 'agreement among raft nodes before linearized reading'  (duration: 444.318226ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:08.858193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:08.413749Z","time spent":"444.439878ms","remote":"127.0.0.1:59188","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":"info","ts":"2026-01-29T15:41:09.179066Z","caller":"traceutil/trace.go:171","msg":"trace[77261043] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"315.12893ms","start":"2026-01-29T15:41:08.863706Z","end":"2026-01-29T15:41:09.178835Z","steps":["trace[77261043] 'process raft request'  (duration: 314.931465ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:09.179301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:08.863692Z","time spent":"315.525279ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:790 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-01-29T15:41:23.417333Z","caller":"traceutil/trace.go:171","msg":"trace[1817095594] linearizableReadLoop","detail":"{readStateIndex:916; appliedIndex:915; }","duration":"123.312458ms","start":"2026-01-29T15:41:23.294003Z","end":"2026-01-29T15:41:23.417315Z","steps":["trace[1817095594] 'read index received'  (duration: 123.239436ms)","trace[1817095594] 'applied index is now lower than readState.Index'  (duration: 72.242µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:41:23.417457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.434911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:41:23.417479Z","caller":"traceutil/trace.go:171","msg":"trace[882513661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:885; }","duration":"123.488063ms","start":"2026-01-29T15:41:23.293983Z","end":"2026-01-29T15:41:23.417471Z","steps":["trace[882513661] 'agreement among raft nodes before linearized reading'  (duration: 123.433571ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:41:23.417607Z","caller":"traceutil/trace.go:171","msg":"trace[1470045800] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"173.167158ms","start":"2026-01-29T15:41:23.244415Z","end":"2026-01-29T15:41:23.417582Z","steps":["trace[1470045800] 'process raft request'  (duration: 172.730038ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:41:23.423844Z","caller":"traceutil/trace.go:171","msg":"trace[772090771] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"112.247542ms","start":"2026-01-29T15:41:23.311586Z","end":"2026-01-29T15:41:23.423834Z","steps":["trace[772090771] 'process raft request'  (duration: 111.951675ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:41:25.988357Z","caller":"traceutil/trace.go:171","msg":"trace[1144449670] linearizableReadLoop","detail":"{readStateIndex:922; appliedIndex:921; }","duration":"244.686193ms","start":"2026-01-29T15:41:25.743648Z","end":"2026-01-29T15:41:25.988335Z","steps":["trace[1144449670] 'read index received'  (duration: 244.479748ms)","trace[1144449670] 'applied index is now lower than readState.Index'  (duration: 205.135µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T15:41:25.988516Z","caller":"traceutil/trace.go:171","msg":"trace[1492108386] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"560.397687ms","start":"2026-01-29T15:41:25.428105Z","end":"2026-01-29T15:41:25.988503Z","steps":["trace[1492108386] 'process raft request'  (duration: 560.054629ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:25.988729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:25.428077Z","time spent":"560.485998ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:885 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-29T15:41:25.988852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.201175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-01-29T15:41:25.988916Z","caller":"traceutil/trace.go:171","msg":"trace[2039780443] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:891; }","duration":"245.254785ms","start":"2026-01-29T15:41:25.743623Z","end":"2026-01-29T15:41:25.988878Z","steps":["trace[2039780443] 'agreement among raft nodes before linearized reading'  (duration: 245.179124ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:25.98876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.627071ms","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-01-29T15:41:25.989038Z","caller":"traceutil/trace.go:171","msg":"trace[1571989231] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:891; }","duration":"244.945428ms","start":"2026-01-29T15:41:25.74408Z","end":"2026-01-29T15:41:25.989025Z","steps":["trace[1571989231] 'agreement among raft nodes before linearized reading'  (duration: 244.533518ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:26.79972Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9823085305775960466,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-29T15:41:26.963314Z","caller":"traceutil/trace.go:171","msg":"trace[2136973166] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"969.665647ms","start":"2026-01-29T15:41:25.993631Z","end":"2026-01-29T15:41:26.963297Z","steps":["trace[2136973166] 'process raft request'  (duration: 969.530024ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:26.963407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:25.993617Z","time spent":"969.741268ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:887 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-29T15:41:27.116475Z","caller":"traceutil/trace.go:171","msg":"trace[285935855] linearizableReadLoop","detail":"{readStateIndex:925; appliedIndex:923; }","duration":"816.897492ms","start":"2026-01-29T15:41:26.299562Z","end":"2026-01-29T15:41:27.116459Z","steps":["trace[285935855] 'read index received'  (duration: 664.103168ms)","trace[285935855] 'applied index is now lower than readState.Index'  (duration: 152.793614ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T15:41:27.116658Z","caller":"traceutil/trace.go:171","msg":"trace[265230463] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"1.121912609s","start":"2026-01-29T15:41:25.994738Z","end":"2026-01-29T15:41:27.116651Z","steps":["trace[265230463] 'process raft request'  (duration: 1.116768489s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:27.116736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:25.994731Z","time spent":"1.12194592s","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:888 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-01-29T15:41:27.116852Z","caller":"traceutil/trace.go:171","msg":"trace[169317181] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"648.161199ms","start":"2026-01-29T15:41:26.468685Z","end":"2026-01-29T15:41:27.116846Z","steps":["trace[169317181] 'process raft request'  (duration: 647.738648ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:27.116883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:26.46867Z","time spent":"648.195999ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:817 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-01-29T15:41:27.117012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.452706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:41:27.117033Z","caller":"traceutil/trace.go:171","msg":"trace[888872522] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:894; }","duration":"817.474127ms","start":"2026-01-29T15:41:26.299552Z","end":"2026-01-29T15:41:27.117027Z","steps":["trace[888872522] 'agreement among raft nodes before linearized reading'  (duration: 817.435106ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:27.117049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:26.299514Z","time spent":"817.532258ms","remote":"127.0.0.1:58930","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-01-29T15:41:27.117205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.771762ms","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-01-29T15:41:27.117223Z","caller":"traceutil/trace.go:171","msg":"trace[722418984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:894; }","duration":"740.829814ms","start":"2026-01-29T15:41:26.376388Z","end":"2026-01-29T15:41:27.117218Z","steps":["trace[722418984] 'agreement among raft nodes before linearized reading'  (duration: 740.746192ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:27.117241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:26.376375Z","time spent":"740.862595ms","remote":"127.0.0.1:59188","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-01-29T15:41:27.117412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.387482ms","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-01-29T15:41:27.117425Z","caller":"traceutil/trace.go:171","msg":"trace[959930209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:894; }","duration":"626.425242ms","start":"2026-01-29T15:41:26.490996Z","end":"2026-01-29T15:41:27.117421Z","steps":["trace[959930209] 'agreement among raft nodes before linearized reading'  (duration: 626.384031ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:27.117436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:26.490984Z","time spent":"626.450153ms","remote":"127.0.0.1:59188","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-01-29T15:41:28.043965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.962436ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823085305775960476 > lease_revoke:<id:08529c0a6922b0c5>","response":"size:29"}
{"level":"info","ts":"2026-01-29T15:41:29.082397Z","caller":"traceutil/trace.go:171","msg":"trace[892847312] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"114.475763ms","start":"2026-01-29T15:41:28.967906Z","end":"2026-01-29T15:41:29.082381Z","steps":["trace[892847312] 'process raft request'  (duration: 114.361311ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:29.286913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.539681ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823085305775960488 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:895 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T15:41:29.287139Z","caller":"traceutil/trace.go:171","msg":"trace[663662527] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"154.493124ms","start":"2026-01-29T15:41:29.13262Z","end":"2026-01-29T15:41:29.287113Z","steps":["trace[663662527] 'process raft request'  (duration: 34.681118ms)","trace[663662527] 'compare'  (duration: 119.402647ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T15:41:29.287761Z","caller":"traceutil/trace.go:171","msg":"trace[2096075275] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"154.364752ms","start":"2026-01-29T15:41:29.133383Z","end":"2026-01-29T15:41:29.287748Z","steps":["trace[2096075275] 'process raft request'  (duration: 154.062044ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:39.448791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156602305s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:41:39.448839Z","caller":"traceutil/trace.go:171","msg":"trace[444095418] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:925; }","duration":"1.156677388s","start":"2026-01-29T15:41:38.29215Z","end":"2026-01-29T15:41:39.448828Z","steps":["trace[444095418] 'range keys from in-memory index tree'  (duration: 1.156564285s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:39.44886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:38.29214Z","time spent":"1.156715978s","remote":"127.0.0.1:58930","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-01-29T15:41:39.448887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.819483ms","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-01-29T15:41:39.448929Z","caller":"traceutil/trace.go:171","msg":"trace[1949639753] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:925; }","duration":"188.891055ms","start":"2026-01-29T15:41:39.260027Z","end":"2026-01-29T15:41:39.448918Z","steps":["trace[1949639753] 'range keys from in-memory index tree'  (duration: 188.71173ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:39.449096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.470161ms","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-01-29T15:41:39.449109Z","caller":"traceutil/trace.go:171","msg":"trace[1601858966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:925; }","duration":"110.506221ms","start":"2026-01-29T15:41:39.338599Z","end":"2026-01-29T15:41:39.449105Z","steps":["trace[1601858966] 'range keys from in-memory index tree'  (duration: 110.410449ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:39.449184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.472481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-01-29T15:41:39.449212Z","caller":"traceutil/trace.go:171","msg":"trace[2046086858] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:925; }","duration":"325.534062ms","start":"2026-01-29T15:41:39.123673Z","end":"2026-01-29T15:41:39.449207Z","steps":["trace[2046086858] 'range keys from in-memory index tree'  (duration: 325.364699ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:39.449229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:39.123654Z","time spent":"325.568164ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-01-29T15:41:39.727279Z","caller":"traceutil/trace.go:171","msg":"trace[533952577] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"272.250903ms","start":"2026-01-29T15:41:39.455012Z","end":"2026-01-29T15:41:39.727262Z","steps":["trace[533952577] 'process raft request'  (duration: 272.12791ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:41:39.72746Z","caller":"traceutil/trace.go:171","msg":"trace[664309389] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"272.390686ms","start":"2026-01-29T15:41:39.455055Z","end":"2026-01-29T15:41:39.727446Z","steps":["trace[664309389] 'process raft request'  (duration: 272.184332ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:41:39.72759Z","caller":"traceutil/trace.go:171","msg":"trace[600846423] linearizableReadLoop","detail":"{readStateIndex:963; appliedIndex:960; }","duration":"266.333305ms","start":"2026-01-29T15:41:39.461245Z","end":"2026-01-29T15:41:39.727578Z","steps":["trace[600846423] 'read index received'  (duration: 66.255172ms)","trace[600846423] 'applied index is now lower than readState.Index'  (duration: 200.077623ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:41:39.727645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.388207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:41:39.727665Z","caller":"traceutil/trace.go:171","msg":"trace[34671574] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:929; }","duration":"266.432128ms","start":"2026-01-29T15:41:39.461227Z","end":"2026-01-29T15:41:39.727659Z","steps":["trace[34671574] 'agreement among raft nodes before linearized reading'  (duration: 266.383107ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:41:39.72768Z","caller":"traceutil/trace.go:171","msg":"trace[1263446621] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"272.597861ms","start":"2026-01-29T15:41:39.455077Z","end":"2026-01-29T15:41:39.727675Z","steps":["trace[1263446621] 'process raft request'  (duration: 272.325304ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:46.105448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.730662ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823085305775960644 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:948 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T15:41:46.105521Z","caller":"traceutil/trace.go:171","msg":"trace[157111594] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"257.851197ms","start":"2026-01-29T15:41:45.847658Z","end":"2026-01-29T15:41:46.105509Z","steps":["trace[157111594] 'process raft request'  (duration: 35.004783ms)","trace[157111594] 'compare'  (duration: 222.617479ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:41:46.353831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.444604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-01-29T15:41:46.353912Z","caller":"traceutil/trace.go:171","msg":"trace[341948031] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:966; }","duration":"142.566437ms","start":"2026-01-29T15:41:46.211331Z","end":"2026-01-29T15:41:46.353897Z","steps":["trace[341948031] 'range keys from in-memory index tree'  (duration: 142.313171ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:46.907098Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9823085305775960647,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-29T15:41:46.937707Z","caller":"traceutil/trace.go:171","msg":"trace[465570775] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1001; }","duration":"531.026493ms","start":"2026-01-29T15:41:46.406663Z","end":"2026-01-29T15:41:46.93769Z","steps":["trace[465570775] 'read index received'  (duration: 530.87302ms)","trace[465570775] 'applied index is now lower than readState.Index'  (duration: 152.753µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:41:46.937843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.153946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:41:46.93787Z","caller":"traceutil/trace.go:171","msg":"trace[2130706065] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:967; }","duration":"531.238368ms","start":"2026-01-29T15:41:46.406625Z","end":"2026-01-29T15:41:46.937863Z","steps":["trace[2130706065] 'agreement among raft nodes before linearized reading'  (duration: 531.146926ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:46.937895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:46.406607Z","time spent":"531.282829ms","remote":"127.0.0.1:59206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":29,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "}
{"level":"info","ts":"2026-01-29T15:41:46.938089Z","caller":"traceutil/trace.go:171","msg":"trace[588510575] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"575.322773ms","start":"2026-01-29T15:41:46.362759Z","end":"2026-01-29T15:41:46.938081Z","steps":["trace[588510575] 'process raft request'  (duration: 574.820182ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:46.938148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:46.362744Z","time spent":"575.364584ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:951 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-01-29T15:41:51.575768Z","caller":"traceutil/trace.go:171","msg":"trace[52698455] linearizableReadLoop","detail":"{readStateIndex:1028; appliedIndex:1027; }","duration":"280.055145ms","start":"2026-01-29T15:41:51.295681Z","end":"2026-01-29T15:41:51.575737Z","steps":["trace[52698455] 'read index received'  (duration: 279.80882ms)","trace[52698455] 'applied index is now lower than readState.Index'  (duration: 245.115µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:41:51.575969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.247019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:41:51.576028Z","caller":"traceutil/trace.go:171","msg":"trace[1849753642] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:992; }","duration":"280.366332ms","start":"2026-01-29T15:41:51.295644Z","end":"2026-01-29T15:41:51.57601Z","steps":["trace[1849753642] 'agreement among raft nodes before linearized reading'  (duration: 280.206278ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:41:51.576352Z","caller":"traceutil/trace.go:171","msg":"trace[890197461] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"611.835103ms","start":"2026-01-29T15:41:50.964501Z","end":"2026-01-29T15:41:51.576336Z","steps":["trace[890197461] 'process raft request'  (duration: 611.074456ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:51.576499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:50.964489Z","time spent":"611.908875ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:980 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-29T15:41:52.282924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.205031ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823085305775960700 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:981 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T15:41:52.283007Z","caller":"traceutil/trace.go:171","msg":"trace[1752978721] linearizableReadLoop","detail":"{readStateIndex:1029; appliedIndex:1028; }","duration":"655.655152ms","start":"2026-01-29T15:41:51.627339Z","end":"2026-01-29T15:41:52.282994Z","steps":["trace[1752978721] 'read index received'  (duration: 371.287468ms)","trace[1752978721] 'applied index is now lower than readState.Index'  (duration: 284.366674ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T15:41:52.283013Z","caller":"traceutil/trace.go:171","msg":"trace[332850461] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"690.318428ms","start":"2026-01-29T15:41:51.592677Z","end":"2026-01-29T15:41:52.282995Z","steps":["trace[332850461] 'process raft request'  (duration: 405.975714ms)","trace[332850461] 'compare'  (duration: 284.056568ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:41:52.283081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.739194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:41:52.283102Z","caller":"traceutil/trace.go:171","msg":"trace[1682997507] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:993; }","duration":"655.797756ms","start":"2026-01-29T15:41:51.627297Z","end":"2026-01-29T15:41:52.283095Z","steps":["trace[1682997507] 'agreement among raft nodes before linearized reading'  (duration: 655.752935ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:52.283124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:51.592654Z","time spent":"690.40097ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:981 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-01-29T15:41:52.283125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:51.627279Z","time spent":"655.839806ms","remote":"127.0.0.1:58110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T15:41:52.28322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.873985ms","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-01-29T15:41:52.283238Z","caller":"traceutil/trace.go:171","msg":"trace[469670979] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:993; }","duration":"492.924857ms","start":"2026-01-29T15:41:51.790307Z","end":"2026-01-29T15:41:52.283232Z","steps":["trace[469670979] 'agreement among raft nodes before linearized reading'  (duration: 492.837745ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:52.283255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:51.79029Z","time spent":"492.962037ms","remote":"127.0.0.1:59188","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-01-29T15:41:52.283445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.923402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-01-29T15:41:52.283466Z","caller":"traceutil/trace.go:171","msg":"trace[1368477973] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:993; }","duration":"423.978603ms","start":"2026-01-29T15:41:51.859481Z","end":"2026-01-29T15:41:52.28346Z","steps":["trace[1368477973] 'agreement among raft nodes before linearized reading'  (duration: 423.902471ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:41:52.283481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T15:41:51.859462Z","time spent":"424.015483ms","remote":"127.0.0.1:59188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-01-29T15:41:56.997607Z","caller":"traceutil/trace.go:171","msg":"trace[1254995901] linearizableReadLoop","detail":"{readStateIndex:1055; appliedIndex:1054; }","duration":"105.130706ms","start":"2026-01-29T15:41:56.892455Z","end":"2026-01-29T15:41:56.997586Z","steps":["trace[1254995901] 'read index received'  (duration: 104.936851ms)","trace[1254995901] 'applied index is now lower than readState.Index'  (duration: 192.955µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:41:56.997763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.286309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:41:56.997798Z","caller":"traceutil/trace.go:171","msg":"trace[495965224] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1018; }","duration":"105.37135ms","start":"2026-01-29T15:41:56.892415Z","end":"2026-01-29T15:41:56.997786Z","steps":["trace[495965224] 'agreement among raft nodes before linearized reading'  (duration: 105.280758ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:41:56.998212Z","caller":"traceutil/trace.go:171","msg":"trace[348560753] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"121.919056ms","start":"2026-01-29T15:41:56.876278Z","end":"2026-01-29T15:41:56.998197Z","steps":["trace[348560753] 'process raft request'  (duration: 121.169588ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:45:03.663151Z","caller":"traceutil/trace.go:171","msg":"trace[1354211420] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"202.733921ms","start":"2026-01-29T15:45:03.460396Z","end":"2026-01-29T15:45:03.66313Z","steps":["trace[1354211420] 'process raft request'  (duration: 202.590608ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:45:10.109598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.642245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"}
{"level":"info","ts":"2026-01-29T15:45:10.10969Z","caller":"traceutil/trace.go:171","msg":"trace[88672205] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1854; }","duration":"131.762428ms","start":"2026-01-29T15:45:09.977907Z","end":"2026-01-29T15:45:10.109669Z","steps":["trace[88672205] 'range keys from in-memory index tree'  (duration: 131.498732ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:45:10.268595Z","caller":"traceutil/trace.go:171","msg":"trace[1718043939] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"152.598361ms","start":"2026-01-29T15:45:10.115972Z","end":"2026-01-29T15:45:10.268571Z","steps":["trace[1718043939] 'process raft request'  (duration: 152.103779ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:45:41.558435Z","caller":"traceutil/trace.go:171","msg":"trace[749720722] linearizableReadLoop","detail":"{readStateIndex:2072; appliedIndex:2071; }","duration":"266.232153ms","start":"2026-01-29T15:45:41.29219Z","end":"2026-01-29T15:45:41.558422Z","steps":["trace[749720722] 'read index received'  (duration: 266.11889ms)","trace[749720722] 'applied index is now lower than readState.Index'  (duration: 112.483µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T15:45:41.558757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.156542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:1 size:214"}
{"level":"info","ts":"2026-01-29T15:45:41.558808Z","caller":"traceutil/trace.go:171","msg":"trace[2004894126] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"279.941676ms","start":"2026-01-29T15:45:41.278857Z","end":"2026-01-29T15:45:41.558799Z","steps":["trace[2004894126] 'process raft request'  (duration: 279.487126ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T15:45:41.558814Z","caller":"traceutil/trace.go:171","msg":"trace[654468622] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:1; response_revision:1989; }","duration":"248.245303ms","start":"2026-01-29T15:45:41.310554Z","end":"2026-01-29T15:45:41.558799Z","steps":["trace[654468622] 'agreement among raft nodes before linearized reading'  (duration: 248.11374ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:45:41.558907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.705753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:45:41.558928Z","caller":"traceutil/trace.go:171","msg":"trace[1889160964] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1989; }","duration":"266.751964ms","start":"2026-01-29T15:45:41.29217Z","end":"2026-01-29T15:45:41.558922Z","steps":["trace[1889160964] 'agreement among raft nodes before linearized reading'  (duration: 266.711673ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:45:41.559029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.758455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T15:45:41.559053Z","caller":"traceutil/trace.go:171","msg":"trace[156289825] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1989; }","duration":"128.806795ms","start":"2026-01-29T15:45:41.430236Z","end":"2026-01-29T15:45:41.559043Z","steps":["trace[156289825] 'agreement among raft nodes before linearized reading'  (duration: 128.768365ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T15:45:41.559194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.538619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"}
{"level":"info","ts":"2026-01-29T15:45:41.559212Z","caller":"traceutil/trace.go:171","msg":"trace[1242975135] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:1989; }","duration":"224.578619ms","start":"2026-01-29T15:45:41.334628Z","end":"2026-01-29T15:45:41.559207Z","steps":["trace[1242975135] 'agreement among raft nodes before linearized reading'  (duration: 224.542808ms)"],"step_count":1}