{"level":"warn","ts":"2026-01-29T03:14:46.984297Z","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-29T03:14:46.984401Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.250: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.250:2380","--initial-cluster=instance=https://162.253.55.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.250: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-29T03:14:46.984624Z","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-29T03:14:46.984644Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.250:2380"]}
{"level":"info","ts":"2026-01-29T03:14:46.984705Z","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-29T03:14:46.989541Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.250:2379"]}
{"level":"info","ts":"2026-01-29T03:14:46.989673Z","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.250:2380"],"listen-peer-urls":["https://162.253.55.250:2380"],"advertise-client-urls":["https://162.253.55.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.250: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-29T03:14:47.001273Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"11.013971ms"}
{"level":"info","ts":"2026-01-29T03:14:47.021423Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1e4a0bccff66c64d","cluster-id":"8ba64f6e83da771"}
{"level":"info","ts":"2026-01-29T03:14:47.021517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d switched to configuration voters=()"}
{"level":"info","ts":"2026-01-29T03:14:47.021537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became follower at term 0"}
{"level":"info","ts":"2026-01-29T03:14:47.021552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1e4a0bccff66c64d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-29T03:14:47.021559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became follower at term 1"}
{"level":"info","ts":"2026-01-29T03:14:47.021679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d switched to configuration voters=(2182569944500586061)"}
{"level":"warn","ts":"2026-01-29T03:14:47.037421Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-29T03:14:47.043951Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-29T03:14:47.053489Z","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-29T03:14:47.061225Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1e4a0bccff66c64d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-29T03:14:47.075675Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1e4a0bccff66c64d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-29T03:14:47.075821Z","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-29T03:14:47.075862Z","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-29T03:14:47.075872Z","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-29T03:14:47.080797Z","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-29T03:14:47.081001Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1e4a0bccff66c64d","initial-advertise-peer-urls":["https://162.253.55.250:2380"],"listen-peer-urls":["https://162.253.55.250:2380"],"advertise-client-urls":["https://162.253.55.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-29T03:14:47.081033Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-29T03:14:47.081089Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.250:2380"}
{"level":"info","ts":"2026-01-29T03:14:47.081099Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.250:2380"}
{"level":"info","ts":"2026-01-29T03:14:47.093701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d switched to configuration voters=(2182569944500586061)"}
{"level":"info","ts":"2026-01-29T03:14:47.093855Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ba64f6e83da771","local-member-id":"1e4a0bccff66c64d","added-peer-id":"1e4a0bccff66c64d","added-peer-peer-urls":["https://162.253.55.250:2380"]}
{"level":"info","ts":"2026-01-29T03:14:48.025081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d is starting a new election at term 1"}
{"level":"info","ts":"2026-01-29T03:14:48.025139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-29T03:14:48.025167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d received MsgPreVoteResp from 1e4a0bccff66c64d at term 1"}
{"level":"info","ts":"2026-01-29T03:14:48.025345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became candidate at term 2"}
{"level":"info","ts":"2026-01-29T03:14:48.025375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d received MsgVoteResp from 1e4a0bccff66c64d at term 2"}
{"level":"info","ts":"2026-01-29T03:14:48.025433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became leader at term 2"}
{"level":"info","ts":"2026-01-29T03:14:48.025446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1e4a0bccff66c64d elected leader 1e4a0bccff66c64d at term 2"}
{"level":"info","ts":"2026-01-29T03:14:48.029279Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1e4a0bccff66c64d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.250:2379]}","request-path":"/0/members/1e4a0bccff66c64d/attributes","cluster-id":"8ba64f6e83da771","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-29T03:14:48.032451Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-29T03:14:48.032591Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-29T03:14:48.033056Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T03:14:48.033235Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-29T03:14:48.033269Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-29T03:14:48.034568Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-29T03:14:48.042561Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ba64f6e83da771","local-member-id":"1e4a0bccff66c64d","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T03:14:48.042939Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T03:14:48.043067Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T03:14:48.050153Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.250:2379"}
{"level":"info","ts":"2026-01-29T03:15:12.082287Z","caller":"traceutil/trace.go:171","msg":"trace[1974444170] linearizableReadLoop","detail":"{readStateIndex:438; appliedIndex:437; }","duration":"309.010033ms","start":"2026-01-29T03:15:11.773256Z","end":"2026-01-29T03:15:12.082266Z","steps":["trace[1974444170] 'read index received'  (duration: 308.84811ms)","trace[1974444170] 'applied index is now lower than readState.Index'  (duration: 161.013µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:15:12.082622Z","caller":"traceutil/trace.go:171","msg":"trace[775338459] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"322.707327ms","start":"2026-01-29T03:15:11.759903Z","end":"2026-01-29T03:15:12.08261Z","steps":["trace[775338459] 'process raft request'  (duration: 322.256937ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:12.084432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.869382ms","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-29T03:15:12.08457Z","caller":"traceutil/trace.go:171","msg":"trace[1080150422] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:424; }","duration":"175.038686ms","start":"2026-01-29T03:15:11.909515Z","end":"2026-01-29T03:15:12.084553Z","steps":["trace[1080150422] 'agreement among raft nodes before linearized reading'  (duration: 174.839742ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:12.085069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.774676ms","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-29T03:15:12.085178Z","caller":"traceutil/trace.go:171","msg":"trace[1735142856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:424; }","duration":"311.94198ms","start":"2026-01-29T03:15:11.773224Z","end":"2026-01-29T03:15:12.085166Z","steps":["trace[1735142856] 'agreement among raft nodes before linearized reading'  (duration: 311.772876ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:12.085274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:11.773209Z","time spent":"312.052823ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-29T03:15:12.087013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:11.759877Z","time spent":"322.773408ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:419 > 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":"warn","ts":"2026-01-29T03:15:12.538565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.999698ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14289248749800419769 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:421 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T03:15:12.538709Z","caller":"traceutil/trace.go:171","msg":"trace[91388593] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"448.574499ms","start":"2026-01-29T03:15:12.090115Z","end":"2026-01-29T03:15:12.53869Z","steps":["trace[91388593] 'process raft request'  (duration: 338.223225ms)","trace[91388593] 'compare'  (duration: 109.894906ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:15:12.538735Z","caller":"traceutil/trace.go:171","msg":"trace[1057689821] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:438; }","duration":"166.155355ms","start":"2026-01-29T03:15:12.372562Z","end":"2026-01-29T03:15:12.538717Z","steps":["trace[1057689821] 'read index received'  (duration: 55.78603ms)","trace[1057689821] 'applied index is now lower than readState.Index'  (duration: 110.368515ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:15:12.538802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:12.0901Z","time spent":"448.64907ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:421 > 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-29T03:15:12.538813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.246827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:12.538887Z","caller":"traceutil/trace.go:171","msg":"trace[1391986725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:426; }","duration":"166.310629ms","start":"2026-01-29T03:15:12.372521Z","end":"2026-01-29T03:15:12.538831Z","steps":["trace[1391986725] 'agreement among raft nodes before linearized reading'  (duration: 166.245577ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:12.538997Z","caller":"traceutil/trace.go:171","msg":"trace[1558147043] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"445.781867ms","start":"2026-01-29T03:15:12.093207Z","end":"2026-01-29T03:15:12.538989Z","steps":["trace[1558147043] 'process raft request'  (duration: 445.4585ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:12.539027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:12.09319Z","time spent":"445.822297ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:420 > 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-29T03:15:18.705979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.879933ms","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-29T03:15:18.706037Z","caller":"traceutil/trace.go:171","msg":"trace[1870307996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:472; }","duration":"595.966484ms","start":"2026-01-29T03:15:18.110056Z","end":"2026-01-29T03:15:18.706022Z","steps":["trace[1870307996] 'range keys from in-memory index tree'  (duration: 595.75165ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:18.706064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:18.110042Z","time spent":"596.015726ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-29T03:15:18.706179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.738768ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:18.70622Z","caller":"traceutil/trace.go:171","msg":"trace[776791977] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:472; }","duration":"586.782928ms","start":"2026-01-29T03:15:18.119431Z","end":"2026-01-29T03:15:18.706214Z","steps":["trace[776791977] 'range keys from in-memory index tree'  (duration: 586.732948ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:18.706341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.439971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:18.706359Z","caller":"traceutil/trace.go:171","msg":"trace[168738996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:472; }","duration":"334.492211ms","start":"2026-01-29T03:15:18.371861Z","end":"2026-01-29T03:15:18.706353Z","steps":["trace[168738996] 'range keys from in-memory index tree'  (duration: 334.349049ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:18.706374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:18.371823Z","time spent":"334.547313ms","remote":"127.0.0.1:59476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-29T03:15:18.706571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.985901ms","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-29T03:15:18.706589Z","caller":"traceutil/trace.go:171","msg":"trace[1472693243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:472; }","duration":"143.031602ms","start":"2026-01-29T03:15:18.563552Z","end":"2026-01-29T03:15:18.706584Z","steps":["trace[1472693243] 'range keys from in-memory index tree'  (duration: 142.881299ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:18.706692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.049734ms","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-29T03:15:18.706708Z","caller":"traceutil/trace.go:171","msg":"trace[2035755461] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:472; }","duration":"141.078955ms","start":"2026-01-29T03:15:18.565624Z","end":"2026-01-29T03:15:18.706703Z","steps":["trace[2035755461] 'range keys from in-memory index tree'  (duration: 140.993094ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:20.160748Z","caller":"traceutil/trace.go:171","msg":"trace[1503515902] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"187.153627ms","start":"2026-01-29T03:15:19.973579Z","end":"2026-01-29T03:15:20.160733Z","steps":["trace[1503515902] 'process raft request'  (duration: 187.069406ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:20.870815Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248749800419909,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T03:15:21.236458Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.009627516s","expected-duration":"1s"}
{"level":"warn","ts":"2026-01-29T03:15:21.526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.259455ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14289248749800419917 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" mod_revision:506 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" value_size:24141 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T03:15:21.52609Z","caller":"traceutil/trace.go:171","msg":"trace[511117668] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"1.299311318s","start":"2026-01-29T03:15:20.226761Z","end":"2026-01-29T03:15:21.526072Z","steps":["trace[511117668] 'process raft request'  (duration: 1.00989787s)","trace[511117668] 'compare'  (duration: 288.98371ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:15:21.526145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:20.226749Z","time spent":"1.299370369s","remote":"127.0.0.1:59516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" mod_revision:506 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" value_size:24141 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" > >"}
{"level":"info","ts":"2026-01-29T03:15:21.756492Z","caller":"traceutil/trace.go:171","msg":"trace[1336280948] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.385176784s","start":"2026-01-29T03:15:20.3713Z","end":"2026-01-29T03:15:21.756477Z","steps":["trace[1336280948] 'process raft request'  (duration: 1.374608151s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.756575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.386746054s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-01-29T03:15:21.756583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:20.371282Z","time spent":"1.385256105s","remote":"127.0.0.1:59516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" value_size:4142 >> failure:<>"}
{"level":"info","ts":"2026-01-29T03:15:21.7566Z","caller":"traceutil/trace.go:171","msg":"trace[752448331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"1.386807635s","start":"2026-01-29T03:15:20.369785Z","end":"2026-01-29T03:15:21.756593Z","steps":["trace[752448331] 'agreement among raft nodes before linearized reading'  (duration: 1.386734784s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.756621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:20.369763Z","time spent":"1.386852716s","remote":"127.0.0.1:59478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-29T03:15:21.756757Z","caller":"traceutil/trace.go:171","msg":"trace[1707657428] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.184176291s","start":"2026-01-29T03:15:20.572575Z","end":"2026-01-29T03:15:21.756751Z","steps":["trace[1707657428] 'process raft request'  (duration: 1.183869446s)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:21.756488Z","caller":"traceutil/trace.go:171","msg":"trace[247093518] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:522; }","duration":"1.386648812s","start":"2026-01-29T03:15:20.36982Z","end":"2026-01-29T03:15:21.756469Z","steps":["trace[247093518] 'read index received'  (duration: 866.859528ms)","trace[247093518] 'applied index is now lower than readState.Index'  (duration: 519.788614ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:15:21.75682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:20.572556Z","time spent":"1.184233802s","remote":"127.0.0.1:59516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" value_size:9240 >> failure:<>"}
{"level":"warn","ts":"2026-01-29T03:15:21.762347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043070896s","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-29T03:15:21.762406Z","caller":"traceutil/trace.go:171","msg":"trace[1692628237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"1.043164778s","start":"2026-01-29T03:15:20.719225Z","end":"2026-01-29T03:15:21.762389Z","steps":["trace[1692628237] 'agreement among raft nodes before linearized reading'  (duration: 1.042995914s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.762442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:20.719206Z","time spent":"1.043228649s","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-01-29T03:15:21.762694Z","caller":"traceutil/trace.go:171","msg":"trace[332252789] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"227.749066ms","start":"2026-01-29T03:15:21.534933Z","end":"2026-01-29T03:15:21.762682Z","steps":["trace[332252789] 'process raft request'  (duration: 227.195166ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.76506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.820426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"}
{"level":"info","ts":"2026-01-29T03:15:21.765684Z","caller":"traceutil/trace.go:171","msg":"trace[278034396] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:511; }","duration":"193.943027ms","start":"2026-01-29T03:15:21.571198Z","end":"2026-01-29T03:15:21.765141Z","steps":["trace[278034396] 'agreement among raft nodes before linearized reading'  (duration: 193.771254ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.76594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.36294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"}
{"level":"info","ts":"2026-01-29T03:15:21.765964Z","caller":"traceutil/trace.go:171","msg":"trace[887447774] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:511; }","duration":"395.423881ms","start":"2026-01-29T03:15:21.370533Z","end":"2026-01-29T03:15:21.765957Z","steps":["trace[887447774] 'agreement among raft nodes before linearized reading'  (duration: 395.33849ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.765981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:21.370515Z","time spent":"395.462162ms","remote":"127.0.0.1:59516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4202,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "}
{"level":"warn","ts":"2026-01-29T03:15:21.766097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.512317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"}
{"level":"info","ts":"2026-01-29T03:15:21.766115Z","caller":"traceutil/trace.go:171","msg":"trace[1795206640] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:511; }","duration":"595.545617ms","start":"2026-01-29T03:15:21.170564Z","end":"2026-01-29T03:15:21.76611Z","steps":["trace[1795206640] 'agreement among raft nodes before linearized reading'  (duration: 595.484616ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.766131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:21.170555Z","time spent":"595.572359ms","remote":"127.0.0.1:59516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5608,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "}
{"level":"warn","ts":"2026-01-29T03:15:21.766212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.965313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.250\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-01-29T03:15:21.766228Z","caller":"traceutil/trace.go:171","msg":"trace[1799617799] range","detail":"{range_begin:/registry/masterleases/162.253.55.250; range_end:; response_count:1; response_revision:511; }","duration":"658.005514ms","start":"2026-01-29T03:15:21.108217Z","end":"2026-01-29T03:15:21.766223Z","steps":["trace[1799617799] 'agreement among raft nodes before linearized reading'  (duration: 657.975094ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.766242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:21.108205Z","time spent":"658.034515ms","remote":"127.0.0.1:59494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.250\" "}
{"level":"warn","ts":"2026-01-29T03:15:21.766347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.385585ms","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-29T03:15:21.766363Z","caller":"traceutil/trace.go:171","msg":"trace[1505180007] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:511; }","duration":"751.433546ms","start":"2026-01-29T03:15:21.014925Z","end":"2026-01-29T03:15:21.766359Z","steps":["trace[1505180007] 'agreement among raft nodes before linearized reading'  (duration: 751.385785ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.766379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:21.014908Z","time spent":"751.466926ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-29T03:15:21.766451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.040619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:21.766466Z","caller":"traceutil/trace.go:171","msg":"trace[581762909] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:511; }","duration":"796.087692ms","start":"2026-01-29T03:15:20.970374Z","end":"2026-01-29T03:15:21.766462Z","steps":["trace[581762909] 'agreement among raft nodes before linearized reading'  (duration: 796.064651ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.766481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:20.97036Z","time spent":"796.118372ms","remote":"127.0.0.1:59516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "}
{"level":"warn","ts":"2026-01-29T03:15:21.766552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"995.450663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:21.766567Z","caller":"traceutil/trace.go:171","msg":"trace[1916507164] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:511; }","duration":"995.489124ms","start":"2026-01-29T03:15:20.771073Z","end":"2026-01-29T03:15:21.766562Z","steps":["trace[1916507164] 'agreement among raft nodes before linearized reading'  (duration: 995.465743ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.766582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:20.771061Z","time spent":"995.517794ms","remote":"127.0.0.1:59516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "}
{"level":"warn","ts":"2026-01-29T03:15:21.767355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.046646935s","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-29T03:15:21.767391Z","caller":"traceutil/trace.go:171","msg":"trace[1470582363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:511; }","duration":"1.046710287s","start":"2026-01-29T03:15:20.720667Z","end":"2026-01-29T03:15:21.767378Z","steps":["trace[1470582363] 'agreement among raft nodes before linearized reading'  (duration: 1.045980442s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.76741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:20.72065Z","time spent":"1.046756427s","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-29T03:15:21.767524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.047080163s","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-29T03:15:21.767541Z","caller":"traceutil/trace.go:171","msg":"trace[1661258141] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:511; }","duration":"1.047124634s","start":"2026-01-29T03:15:20.720411Z","end":"2026-01-29T03:15:21.767536Z","steps":["trace[1661258141] 'agreement among raft nodes before linearized reading'  (duration: 1.047076243s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:21.767556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:20.720401Z","time spent":"1.047151035s","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-01-29T03:15:23.298398Z","caller":"traceutil/trace.go:171","msg":"trace[1669055291] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"295.22037ms","start":"2026-01-29T03:15:23.003162Z","end":"2026-01-29T03:15:23.298382Z","steps":["trace[1669055291] 'process raft request'  (duration: 294.580348ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:23.29853Z","caller":"traceutil/trace.go:171","msg":"trace[800074514] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:541; }","duration":"295.010764ms","start":"2026-01-29T03:15:23.003513Z","end":"2026-01-29T03:15:23.298524Z","steps":["trace[800074514] 'read index received'  (duration: 295.001754ms)","trace[800074514] 'applied index is now lower than readState.Index'  (duration: 8.66µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:15:23.29863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.103646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"}
{"level":"info","ts":"2026-01-29T03:15:23.298651Z","caller":"traceutil/trace.go:171","msg":"trace[937674022] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:525; }","duration":"295.149818ms","start":"2026-01-29T03:15:23.003495Z","end":"2026-01-29T03:15:23.298645Z","steps":["trace[937674022] 'agreement among raft nodes before linearized reading'  (duration: 295.063746ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:23.502576Z","caller":"traceutil/trace.go:171","msg":"trace[169697916] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:541; }","duration":"204.020601ms","start":"2026-01-29T03:15:23.298541Z","end":"2026-01-29T03:15:23.502562Z","steps":["trace[169697916] 'read index received'  (duration: 201.989853ms)","trace[169697916] 'applied index is now lower than readState.Index'  (duration: 2.030218ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:15:23.502642Z","caller":"traceutil/trace.go:171","msg":"trace[128046503] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"465.640626ms","start":"2026-01-29T03:15:23.036994Z","end":"2026-01-29T03:15:23.502635Z","steps":["trace[128046503] 'process raft request'  (duration: 463.645748ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:23.50271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:23.036976Z","time spent":"465.681127ms","remote":"127.0.0.1:59516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" mod_revision:524 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" value_size:188130 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" > >"}
{"level":"warn","ts":"2026-01-29T03:15:23.502923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.470184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"}
{"level":"info","ts":"2026-01-29T03:15:23.502941Z","caller":"traceutil/trace.go:171","msg":"trace[2074042311] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:526; }","duration":"331.521554ms","start":"2026-01-29T03:15:23.171413Z","end":"2026-01-29T03:15:23.502935Z","steps":["trace[2074042311] 'agreement among raft nodes before linearized reading'  (duration: 331.448493ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:23.502955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:23.171391Z","time spent":"331.560895ms","remote":"127.0.0.1:59516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10399,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "}
{"level":"warn","ts":"2026-01-29T03:15:23.503006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.335005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:23.503016Z","caller":"traceutil/trace.go:171","msg":"trace[673535767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:526; }","duration":"134.374556ms","start":"2026-01-29T03:15:23.368638Z","end":"2026-01-29T03:15:23.503013Z","steps":["trace[673535767] 'agreement among raft nodes before linearized reading'  (duration: 134.356646ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:23.503188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.437949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"}
{"level":"info","ts":"2026-01-29T03:15:23.503201Z","caller":"traceutil/trace.go:171","msg":"trace[1237512514] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:526; }","duration":"132.462039ms","start":"2026-01-29T03:15:23.370736Z","end":"2026-01-29T03:15:23.503198Z","steps":["trace[1237512514] 'agreement among raft nodes before linearized reading'  (duration: 132.338897ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:24.821622Z","caller":"traceutil/trace.go:171","msg":"trace[1151040811] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:550; }","duration":"306.640379ms","start":"2026-01-29T03:15:24.514964Z","end":"2026-01-29T03:15:24.821604Z","steps":["trace[1151040811] 'read index received'  (duration: 306.469845ms)","trace[1151040811] 'applied index is now lower than readState.Index'  (duration: 169.854µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:15:24.821708Z","caller":"traceutil/trace.go:171","msg":"trace[467614428] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"324.527731ms","start":"2026-01-29T03:15:24.497176Z","end":"2026-01-29T03:15:24.821703Z","steps":["trace[467614428] 'process raft request'  (duration: 324.329168ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:24.821775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:24.497162Z","time spent":"324.561923ms","remote":"127.0.0.1:59662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:529 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4487 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-01-29T03:15:24.82187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.903513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:24.821889Z","caller":"traceutil/trace.go:171","msg":"trace[632000320] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:535; }","duration":"306.942664ms","start":"2026-01-29T03:15:24.51494Z","end":"2026-01-29T03:15:24.821882Z","steps":["trace[632000320] 'agreement among raft nodes before linearized reading'  (duration: 306.911543ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:24.821905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:24.514928Z","time spent":"306.972774ms","remote":"127.0.0.1:46586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 "}
{"level":"warn","ts":"2026-01-29T03:15:24.822048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.042806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:24.82206Z","caller":"traceutil/trace.go:171","msg":"trace[1151467961] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:535; }","duration":"307.062836ms","start":"2026-01-29T03:15:24.514994Z","end":"2026-01-29T03:15:24.822057Z","steps":["trace[1151467961] 'agreement among raft nodes before linearized reading'  (duration: 307.042136ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:24.822074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:24.51499Z","time spent":"307.079866ms","remote":"127.0.0.1:46586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 "}
{"level":"warn","ts":"2026-01-29T03:15:24.822101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.101478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-01-29T03:15:24.822159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.03031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:24.822177Z","caller":"traceutil/trace.go:171","msg":"trace[628150112] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:535; }","duration":"279.05374ms","start":"2026-01-29T03:15:24.543118Z","end":"2026-01-29T03:15:24.822172Z","steps":["trace[628150112] 'agreement among raft nodes before linearized reading'  (duration: 279.024159ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:24.822167Z","caller":"traceutil/trace.go:171","msg":"trace[1356048503] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:535; }","duration":"269.208062ms","start":"2026-01-29T03:15:24.552942Z","end":"2026-01-29T03:15:24.82215Z","steps":["trace[1356048503] 'agreement among raft nodes before linearized reading'  (duration: 269.107299ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:24.822208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.091611ms","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-29T03:15:24.822221Z","caller":"traceutil/trace.go:171","msg":"trace[1274257505] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:535; }","duration":"279.104931ms","start":"2026-01-29T03:15:24.543112Z","end":"2026-01-29T03:15:24.822217Z","steps":["trace[1274257505] 'agreement among raft nodes before linearized reading'  (duration: 279.084981ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:24.822294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.203473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:24.822308Z","caller":"traceutil/trace.go:171","msg":"trace[736699146] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:535; }","duration":"279.240474ms","start":"2026-01-29T03:15:24.543064Z","end":"2026-01-29T03:15:24.822304Z","steps":["trace[736699146] 'agreement among raft nodes before linearized reading'  (duration: 279.214823ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:24.822365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.263541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:24.822379Z","caller":"traceutil/trace.go:171","msg":"trace[560436390] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:535; }","duration":"307.317322ms","start":"2026-01-29T03:15:24.515058Z","end":"2026-01-29T03:15:24.822376Z","steps":["trace[560436390] 'agreement among raft nodes before linearized reading'  (duration: 307.295281ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:24.822392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:24.515041Z","time spent":"307.347372ms","remote":"127.0.0.1:46586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T03:15:24.822419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.387664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:24.82245Z","caller":"traceutil/trace.go:171","msg":"trace[1307177283] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:535; }","duration":"269.427715ms","start":"2026-01-29T03:15:24.553013Z","end":"2026-01-29T03:15:24.822441Z","steps":["trace[1307177283] 'agreement among raft nodes before linearized reading'  (duration: 269.376284ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:24.822563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.550368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:24.82259Z","caller":"traceutil/trace.go:171","msg":"trace[78369783] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:535; }","duration":"269.587059ms","start":"2026-01-29T03:15:24.552993Z","end":"2026-01-29T03:15:24.82258Z","steps":["trace[78369783] 'agreement among raft nodes before linearized reading'  (duration: 269.548438ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:29.417035Z","caller":"traceutil/trace.go:171","msg":"trace[1851405240] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"556.239703ms","start":"2026-01-29T03:15:28.860777Z","end":"2026-01-29T03:15:29.417017Z","steps":["trace[1851405240] 'process raft request'  (duration: 555.770814ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:29.417149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:28.86076Z","time spent":"556.334714ms","remote":"127.0.0.1:59670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-s5q67\" mod_revision:457 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-s5q67\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-s5q67\" > >"}
{"level":"warn","ts":"2026-01-29T03:15:30.327282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.623276ms","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-29T03:15:30.327361Z","caller":"traceutil/trace.go:171","msg":"trace[1361581028] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:549; }","duration":"477.746588ms","start":"2026-01-29T03:15:29.849598Z","end":"2026-01-29T03:15:30.327344Z","steps":["trace[1361581028] 'range keys from in-memory index tree'  (duration: 477.458393ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:30.3274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:29.849583Z","time spent":"477.80861ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-29T03:15:30.327594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.342279ms","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-29T03:15:30.327621Z","caller":"traceutil/trace.go:171","msg":"trace[1789620221] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:549; }","duration":"504.406341ms","start":"2026-01-29T03:15:29.823205Z","end":"2026-01-29T03:15:30.327612Z","steps":["trace[1789620221] 'range keys from in-memory index tree'  (duration: 504.140685ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:30.327644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:29.823184Z","time spent":"504.454621ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-29T03:15:30.327778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.412091ms","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-29T03:15:30.327802Z","caller":"traceutil/trace.go:171","msg":"trace[2025564967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:549; }","duration":"504.449861ms","start":"2026-01-29T03:15:29.823345Z","end":"2026-01-29T03:15:30.327795Z","steps":["trace[2025564967] 'range keys from in-memory index tree'  (duration: 504.312159ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:30.327825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:29.823339Z","time spent":"504.480692ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-29T03:15:30.327948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.612904ms","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-29T03:15:30.327972Z","caller":"traceutil/trace.go:171","msg":"trace[137586510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:549; }","duration":"504.652545ms","start":"2026-01-29T03:15:29.823312Z","end":"2026-01-29T03:15:30.327965Z","steps":["trace[137586510] 'range keys from in-memory index tree'  (duration: 504.485111ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:30.327997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:29.823303Z","time spent":"504.688736ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-29T03:15:30.326931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.857016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-01-29T03:15:30.328051Z","caller":"traceutil/trace.go:171","msg":"trace[743199703] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:549; }","duration":"509.027509ms","start":"2026-01-29T03:15:29.819002Z","end":"2026-01-29T03:15:30.328029Z","steps":["trace[743199703] 'range keys from in-memory index tree'  (duration: 507.600611ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:30.328414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:29.818984Z","time spent":"509.412695ms","remote":"127.0.0.1:59728","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-29T03:15:30.349805Z","caller":"traceutil/trace.go:171","msg":"trace[846490703] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"316.549199ms","start":"2026-01-29T03:15:30.03305Z","end":"2026-01-29T03:15:30.349599Z","steps":["trace[846490703] 'process raft request'  (duration: 316.305904ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:30.350948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:30.033008Z","time spent":"317.814372ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:500 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-01-29T03:15:30.705812Z","caller":"traceutil/trace.go:171","msg":"trace[132719780] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:567; }","duration":"325.200855ms","start":"2026-01-29T03:15:30.38059Z","end":"2026-01-29T03:15:30.705791Z","steps":["trace[132719780] 'read index received'  (duration: 324.899508ms)","trace[132719780] 'applied index is now lower than readState.Index'  (duration: 300.157µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:15:30.705988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.382188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:30.706027Z","caller":"traceutil/trace.go:171","msg":"trace[731616100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:555; }","duration":"325.47274ms","start":"2026-01-29T03:15:30.380544Z","end":"2026-01-29T03:15:30.706017Z","steps":["trace[731616100] 'agreement among raft nodes before linearized reading'  (duration: 325.333517ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:30.706059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:30.380524Z","time spent":"325.52849ms","remote":"127.0.0.1:59476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-29T03:15:30.706306Z","caller":"traceutil/trace.go:171","msg":"trace[2107741526] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"371.060603ms","start":"2026-01-29T03:15:30.335235Z","end":"2026-01-29T03:15:30.706295Z","steps":["trace[2107741526] 'process raft request'  (duration: 370.302319ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:30.706399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:30.335219Z","time spent":"371.120535ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:543 > 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-29T03:15:30.70675Z","caller":"traceutil/trace.go:171","msg":"trace[1750273566] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"369.984832ms","start":"2026-01-29T03:15:30.336749Z","end":"2026-01-29T03:15:30.706733Z","steps":["trace[1750273566] 'process raft request'  (duration: 368.982623ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:30.706889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:30.33674Z","time spent":"370.041264ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:544 > 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-29T03:15:30.707095Z","caller":"traceutil/trace.go:171","msg":"trace[1119771833] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"371.788767ms","start":"2026-01-29T03:15:30.335296Z","end":"2026-01-29T03:15:30.707085Z","steps":["trace[1119771833] 'process raft request'  (duration: 370.36651ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:30.707774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:30.335292Z","time spent":"371.836138ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:545 > 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-29T03:15:30.709118Z","caller":"traceutil/trace.go:171","msg":"trace[91474583] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"373.784626ms","start":"2026-01-29T03:15:30.335325Z","end":"2026-01-29T03:15:30.709109Z","steps":["trace[91474583] 'process raft request'  (duration: 370.378711ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:30.709413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:30.33532Z","time spent":"373.834187ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:541 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-29T03:15:30.709066Z","caller":"traceutil/trace.go:171","msg":"trace[809518329] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"371.92481ms","start":"2026-01-29T03:15:30.337127Z","end":"2026-01-29T03:15:30.709052Z","steps":["trace[809518329] 'process raft request'  (duration: 368.633827ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:30.711112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:30.33712Z","time spent":"373.852306ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:542 > 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-29T03:15:40.591963Z","caller":"traceutil/trace.go:171","msg":"trace[321742508] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"431.393761ms","start":"2026-01-29T03:15:40.160554Z","end":"2026-01-29T03:15:40.591948Z","steps":["trace[321742508] 'process raft request'  (duration: 430.907161ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:40.592093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:40.160539Z","time spent":"431.488522ms","remote":"127.0.0.1:59670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18235,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-s5q67\" mod_revision:597 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-s5q67\" value_size:18186 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-s5q67\" > >"}
{"level":"warn","ts":"2026-01-29T03:15:40.592671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.763482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:40.592711Z","caller":"traceutil/trace.go:171","msg":"trace[748982417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"220.841034ms","start":"2026-01-29T03:15:40.371859Z","end":"2026-01-29T03:15:40.5927Z","steps":["trace[748982417] 'agreement among raft nodes before linearized reading'  (duration: 220.771223ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:40.593023Z","caller":"traceutil/trace.go:171","msg":"trace[1738444142] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"219.712962ms","start":"2026-01-29T03:15:40.371899Z","end":"2026-01-29T03:15:40.591612Z","steps":["trace[1738444142] 'read index received'  (duration: 219.536189ms)","trace[1738444142] 'applied index is now lower than readState.Index'  (duration: 175.563µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:15:40.883776Z","caller":"traceutil/trace.go:171","msg":"trace[1605644267] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"141.473782ms","start":"2026-01-29T03:15:40.742287Z","end":"2026-01-29T03:15:40.883761Z","steps":["trace[1605644267] 'process raft request'  (duration: 141.37916ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:41.102167Z","caller":"traceutil/trace.go:171","msg":"trace[666288862] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"338.056171ms","start":"2026-01-29T03:15:40.764095Z","end":"2026-01-29T03:15:41.102151Z","steps":["trace[666288862] 'read index received'  (duration: 120.074262ms)","trace[666288862] 'applied index is now lower than readState.Index'  (duration: 217.981129ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:15:41.102287Z","caller":"traceutil/trace.go:171","msg":"trace[1924519289] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"358.161956ms","start":"2026-01-29T03:15:40.744117Z","end":"2026-01-29T03:15:41.102279Z","steps":["trace[1924519289] 'process raft request'  (duration: 353.203141ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:41.102366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:40.744108Z","time spent":"358.207747ms","remote":"127.0.0.1:59930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14311,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/daemonsets/kube-system/cilium\" mod_revision:459 > success:<request_put:<key:\"/registry/daemonsets/kube-system/cilium\" value_size:14264 >> failure:<request_range:<key:\"/registry/daemonsets/kube-system/cilium\" > >"}
{"level":"warn","ts":"2026-01-29T03:15:41.102373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.270944ms","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-29T03:15:41.102419Z","caller":"traceutil/trace.go:171","msg":"trace[1338804810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"338.349546ms","start":"2026-01-29T03:15:40.764059Z","end":"2026-01-29T03:15:41.102408Z","steps":["trace[1338804810] 'agreement among raft nodes before linearized reading'  (duration: 338.236524ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:41.102444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:40.764006Z","time spent":"338.433308ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-01-29T03:15:41.142269Z","caller":"traceutil/trace.go:171","msg":"trace[961696330] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"254.0421ms","start":"2026-01-29T03:15:40.888201Z","end":"2026-01-29T03:15:41.142243Z","steps":["trace[961696330] 'process raft request'  (duration: 253.909578ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:41.142444Z","caller":"traceutil/trace.go:171","msg":"trace[1012610796] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"252.97241ms","start":"2026-01-29T03:15:40.889312Z","end":"2026-01-29T03:15:41.142284Z","steps":["trace[1012610796] 'process raft request'  (duration: 252.874648ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:41.14258Z","caller":"traceutil/trace.go:171","msg":"trace[760988971] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"253.069162ms","start":"2026-01-29T03:15:40.889505Z","end":"2026-01-29T03:15:41.142574Z","steps":["trace[760988971] 'process raft request'  (duration: 252.702315ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:41.142773Z","caller":"traceutil/trace.go:171","msg":"trace[1961853016] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"249.028354ms","start":"2026-01-29T03:15:40.893739Z","end":"2026-01-29T03:15:41.142767Z","steps":["trace[1961853016] 'process raft request'  (duration: 248.488854ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:41.142973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.097771ms","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":"warn","ts":"2026-01-29T03:15:41.143026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.897019ms","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-29T03:15:41.143048Z","caller":"traceutil/trace.go:171","msg":"trace[1857147342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:619; }","duration":"347.932839ms","start":"2026-01-29T03:15:40.795109Z","end":"2026-01-29T03:15:41.143042Z","steps":["trace[1857147342] 'agreement among raft nodes before linearized reading'  (duration: 347.888748ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:41.143031Z","caller":"traceutil/trace.go:171","msg":"trace[1509551828] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:619; }","duration":"338.174282ms","start":"2026-01-29T03:15:40.80485Z","end":"2026-01-29T03:15:41.143025Z","steps":["trace[1509551828] 'agreement among raft nodes before linearized reading'  (duration: 338.0572ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:41.142984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.087381ms","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-29T03:15:41.143251Z","caller":"traceutil/trace.go:171","msg":"trace[1925389251] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:619; }","duration":"375.383946ms","start":"2026-01-29T03:15:40.767862Z","end":"2026-01-29T03:15:41.143246Z","steps":["trace[1925389251] 'agreement among raft nodes before linearized reading'  (duration: 375.0492ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:41.14327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:40.767853Z","time spent":"375.412706ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-29T03:15:41.143121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.431477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-01-29T03:15:41.143338Z","caller":"traceutil/trace.go:171","msg":"trace[1262795843] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"363.670121ms","start":"2026-01-29T03:15:40.779664Z","end":"2026-01-29T03:15:41.143334Z","steps":["trace[1262795843] 'agreement among raft nodes before linearized reading'  (duration: 363.431636ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:41.143355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:40.779654Z","time spent":"363.697302ms","remote":"127.0.0.1:59728","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-29T03:15:41.143325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:40.804844Z","time spent":"338.397987ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-29T03:15:41.143086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:40.79506Z","time spent":"348.002951ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-29T03:15:46.86989Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248749800420273,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T03:15:47.969409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.062520503s","expected-duration":"100ms","prefix":"","request":"header:<ID:14289248749800420276 > lease_revoke:<id:464d9c07bf0c72d3>","response":"size:27"}
{"level":"info","ts":"2026-01-29T03:15:47.969474Z","caller":"traceutil/trace.go:171","msg":"trace[1884242809] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:710; }","duration":"1.599670091s","start":"2026-01-29T03:15:46.369792Z","end":"2026-01-29T03:15:47.969462Z","steps":["trace[1884242809] 'read index received'  (duration: 537.031406ms)","trace[1884242809] 'applied index is now lower than readState.Index'  (duration: 1.062637625s)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:15:47.969815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.600016497s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:15:47.969831Z","caller":"traceutil/trace.go:171","msg":"trace[2008784955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:689; }","duration":"1.600067027s","start":"2026-01-29T03:15:46.369758Z","end":"2026-01-29T03:15:47.969825Z","steps":["trace[2008784955] 'agreement among raft nodes before linearized reading'  (duration: 1.600027927s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:47.969846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:46.369743Z","time spent":"1.600099648s","remote":"127.0.0.1:59476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-29T03:15:47.969992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.122395ms","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-29T03:15:47.970004Z","caller":"traceutil/trace.go:171","msg":"trace[815220917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:689; }","duration":"781.167375ms","start":"2026-01-29T03:15:47.188833Z","end":"2026-01-29T03:15:47.97Z","steps":["trace[815220917] 'agreement among raft nodes before linearized reading'  (duration: 781.101314ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:47.970027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:47.188815Z","time spent":"781.197715ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-29T03:15:47.970134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.264184ms","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-29T03:15:47.970146Z","caller":"traceutil/trace.go:171","msg":"trace[1031764469] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:689; }","duration":"758.288105ms","start":"2026-01-29T03:15:47.211854Z","end":"2026-01-29T03:15:47.970142Z","steps":["trace[1031764469] 'agreement among raft nodes before linearized reading'  (duration: 758.253054ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:47.970157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:47.211848Z","time spent":"758.306605ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-29T03:15:47.970235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.638778ms","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-29T03:15:47.970248Z","caller":"traceutil/trace.go:171","msg":"trace[2001025556] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:689; }","duration":"759.664598ms","start":"2026-01-29T03:15:47.21058Z","end":"2026-01-29T03:15:47.970244Z","steps":["trace[2001025556] 'agreement among raft nodes before linearized reading'  (duration: 759.629698ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:47.970259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:47.210573Z","time spent":"759.68345ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-29T03:15:47.97033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.748543ms","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-29T03:15:47.970342Z","caller":"traceutil/trace.go:171","msg":"trace[110227108] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:689; }","duration":"763.781363ms","start":"2026-01-29T03:15:47.206557Z","end":"2026-01-29T03:15:47.970339Z","steps":["trace[110227108] 'agreement among raft nodes before linearized reading'  (duration: 763.748543ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:47.970352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:47.206547Z","time spent":"763.803213ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-29T03:15:47.97042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.936437ms","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-29T03:15:47.970432Z","caller":"traceutil/trace.go:171","msg":"trace[1474001009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:689; }","duration":"772.965389ms","start":"2026-01-29T03:15:47.197462Z","end":"2026-01-29T03:15:47.970428Z","steps":["trace[1474001009] 'agreement among raft nodes before linearized reading'  (duration: 772.934498ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:47.970445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:47.197452Z","time spent":"772.989129ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-01-29T03:15:51.450011Z","caller":"traceutil/trace.go:171","msg":"trace[618119903] linearizableReadLoop","detail":"{readStateIndex:722; appliedIndex:721; }","duration":"340.155313ms","start":"2026-01-29T03:15:51.10984Z","end":"2026-01-29T03:15:51.449996Z","steps":["trace[618119903] 'read index received'  (duration: 340.02228ms)","trace[618119903] 'applied index is now lower than readState.Index'  (duration: 132.523µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:15:51.45017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.304676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.250\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-01-29T03:15:51.450188Z","caller":"traceutil/trace.go:171","msg":"trace[1181225141] range","detail":"{range_begin:/registry/masterleases/162.253.55.250; range_end:; response_count:1; response_revision:700; }","duration":"340.367486ms","start":"2026-01-29T03:15:51.109814Z","end":"2026-01-29T03:15:51.450181Z","steps":["trace[1181225141] 'agreement among raft nodes before linearized reading'  (duration: 340.239234ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:51.450206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:51.109802Z","time spent":"340.400427ms","remote":"127.0.0.1:59494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.250\" "}
{"level":"info","ts":"2026-01-29T03:15:51.450427Z","caller":"traceutil/trace.go:171","msg":"trace[1296448820] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"486.924617ms","start":"2026-01-29T03:15:50.963497Z","end":"2026-01-29T03:15:51.450422Z","steps":["trace[1296448820] 'process raft request'  (duration: 486.404358ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:51.450474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:50.963481Z","time spent":"486.957757ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:612 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-01-29T03:15:51.770344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:15:51.451948Z","time spent":"318.390772ms","remote":"127.0.0.1:59494","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-01-29T03:15:51.927152Z","caller":"traceutil/trace.go:171","msg":"trace[1770658736] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"155.360277ms","start":"2026-01-29T03:15:51.771774Z","end":"2026-01-29T03:15:51.927134Z","steps":["trace[1770658736] 'process raft request'  (duration: 155.306816ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:15:51.927283Z","caller":"traceutil/trace.go:171","msg":"trace[1706323758] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"173.813888ms","start":"2026-01-29T03:15:51.753441Z","end":"2026-01-29T03:15:51.927255Z","steps":["trace[1706323758] 'process raft request'  (duration: 123.542357ms)","trace[1706323758] 'compare'  (duration: 49.961125ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:15:52.215085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.267636ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14289248749800420312 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:695 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T03:15:52.215171Z","caller":"traceutil/trace.go:171","msg":"trace[335891656] linearizableReadLoop","detail":"{readStateIndex:726; appliedIndex:725; }","duration":"226.576765ms","start":"2026-01-29T03:15:51.988582Z","end":"2026-01-29T03:15:52.215159Z","steps":["trace[335891656] 'read index received'  (duration: 42.120895ms)","trace[335891656] 'applied index is now lower than readState.Index'  (duration: 184.45502ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:15:52.215236Z","caller":"traceutil/trace.go:171","msg":"trace[224371805] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"226.794149ms","start":"2026-01-29T03:15:51.988434Z","end":"2026-01-29T03:15:52.215228Z","steps":["trace[224371805] 'process raft request'  (duration: 42.317419ms)","trace[224371805] 'compare'  (duration: 184.148584ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:15:52.215352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.106418ms","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-29T03:15:52.215413Z","caller":"traceutil/trace.go:171","msg":"trace[839193044] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:703; }","duration":"167.19951ms","start":"2026-01-29T03:15:52.048198Z","end":"2026-01-29T03:15:52.215397Z","steps":["trace[839193044] 'agreement among raft nodes before linearized reading'  (duration: 167.043397ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:52.215557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.971012ms","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-29T03:15:52.215582Z","caller":"traceutil/trace.go:171","msg":"trace[2100693239] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:703; }","duration":"227.006663ms","start":"2026-01-29T03:15:51.988568Z","end":"2026-01-29T03:15:52.215574Z","steps":["trace[2100693239] 'agreement among raft nodes before linearized reading'  (duration: 226.935362ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:52.215663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.384962ms","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-29T03:15:52.215688Z","caller":"traceutil/trace.go:171","msg":"trace[1936678487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:703; }","duration":"148.440404ms","start":"2026-01-29T03:15:52.067239Z","end":"2026-01-29T03:15:52.21568Z","steps":["trace[1936678487] 'agreement among raft nodes before linearized reading'  (duration: 148.348812ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:15:52.215749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.921312ms","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-29T03:15:52.21578Z","caller":"traceutil/trace.go:171","msg":"trace[735866659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:703; }","duration":"148.986984ms","start":"2026-01-29T03:15:52.066785Z","end":"2026-01-29T03:15:52.215772Z","steps":["trace[735866659] 'agreement among raft nodes before linearized reading'  (duration: 148.910302ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:04.584923Z","caller":"traceutil/trace.go:171","msg":"trace[926189324] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:767; }","duration":"301.656013ms","start":"2026-01-29T03:16:04.283251Z","end":"2026-01-29T03:16:04.584907Z","steps":["trace[926189324] 'read index received'  (duration: 301.49506ms)","trace[926189324] 'applied index is now lower than readState.Index'  (duration: 160.303µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:16:04.585298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.029849ms","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-29T03:16:04.58582Z","caller":"traceutil/trace.go:171","msg":"trace[1294221426] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:743; }","duration":"302.579599ms","start":"2026-01-29T03:16:04.283228Z","end":"2026-01-29T03:16:04.585808Z","steps":["trace[1294221426] 'agreement among raft nodes before linearized reading'  (duration: 301.971518ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:04.585985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:04.283219Z","time spent":"302.706822ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-29T03:16:04.585825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.558229ms","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-29T03:16:04.586285Z","caller":"traceutil/trace.go:171","msg":"trace[2036248692] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:744; }","duration":"293.026318ms","start":"2026-01-29T03:16:04.29325Z","end":"2026-01-29T03:16:04.586276Z","steps":["trace[2036248692] 'agreement among raft nodes before linearized reading'  (duration: 292.504638ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:04.585719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.888743ms","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-29T03:16:04.586544Z","caller":"traceutil/trace.go:171","msg":"trace[2107498306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:744; }","duration":"255.749449ms","start":"2026-01-29T03:16:04.330787Z","end":"2026-01-29T03:16:04.586536Z","steps":["trace[2107498306] 'agreement among raft nodes before linearized reading'  (duration: 254.863743ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:04.585722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.033537ms","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-29T03:16:04.587138Z","caller":"traceutil/trace.go:171","msg":"trace[1302562750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:744; }","duration":"294.486533ms","start":"2026-01-29T03:16:04.292642Z","end":"2026-01-29T03:16:04.587129Z","steps":["trace[1302562750] 'agreement among raft nodes before linearized reading'  (duration: 292.963926ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:04.585756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.857007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:16:04.587293Z","caller":"traceutil/trace.go:171","msg":"trace[1203815301] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:744; }","duration":"215.383374ms","start":"2026-01-29T03:16:04.371878Z","end":"2026-01-29T03:16:04.587261Z","steps":["trace[1203815301] 'agreement among raft nodes before linearized reading'  (duration: 213.860316ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:04.585328Z","caller":"traceutil/trace.go:171","msg":"trace[1831398567] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"303.136528ms","start":"2026-01-29T03:16:04.282185Z","end":"2026-01-29T03:16:04.585321Z","steps":["trace[1831398567] 'process raft request'  (duration: 301.915906ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:04.587525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:04.282135Z","time spent":"305.310598ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:738 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-29T03:16:08.904954Z","caller":"traceutil/trace.go:171","msg":"trace[531544938] linearizableReadLoop","detail":"{readStateIndex:780; appliedIndex:779; }","duration":"300.651265ms","start":"2026-01-29T03:16:08.604282Z","end":"2026-01-29T03:16:08.904933Z","steps":["trace[531544938] 'read index received'  (duration: 300.3659ms)","trace[531544938] 'applied index is now lower than readState.Index'  (duration: 284.395µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:16:08.905387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.087783ms","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-29T03:16:08.905961Z","caller":"traceutil/trace.go:171","msg":"trace[736011425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:754; }","duration":"301.675293ms","start":"2026-01-29T03:16:08.604243Z","end":"2026-01-29T03:16:08.905918Z","steps":["trace[736011425] 'agreement among raft nodes before linearized reading'  (duration: 300.936279ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:08.906074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:08.604229Z","time spent":"301.779705ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-29T03:16:08.907807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.617029ms","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-29T03:16:08.905731Z","caller":"traceutil/trace.go:171","msg":"trace[749199019] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"302.66671ms","start":"2026-01-29T03:16:08.603035Z","end":"2026-01-29T03:16:08.905701Z","steps":["trace[749199019] 'process raft request'  (duration: 301.666912ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:08.908186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:08.602994Z","time spent":"305.062123ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:749 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-29T03:16:08.907901Z","caller":"traceutil/trace.go:171","msg":"trace[913015467] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:754; }","duration":"273.746571ms","start":"2026-01-29T03:16:08.634128Z","end":"2026-01-29T03:16:08.907875Z","steps":["trace[913015467] 'agreement among raft nodes before linearized reading'  (duration: 272.455158ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:08.908956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.819061ms","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-29T03:16:08.90904Z","caller":"traceutil/trace.go:171","msg":"trace[2113367610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:754; }","duration":"269.923873ms","start":"2026-01-29T03:16:08.639104Z","end":"2026-01-29T03:16:08.909028Z","steps":["trace[2113367610] 'agreement among raft nodes before linearized reading'  (duration: 269.377954ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:08.909445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.790472ms","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-29T03:16:08.909511Z","caller":"traceutil/trace.go:171","msg":"trace[505479783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:754; }","duration":"273.892814ms","start":"2026-01-29T03:16:08.635607Z","end":"2026-01-29T03:16:08.909499Z","steps":["trace[505479783] 'agreement among raft nodes before linearized reading'  (duration: 273.715001ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:09.267373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.088118ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14289248749800420444 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:750 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T03:16:09.267468Z","caller":"traceutil/trace.go:171","msg":"trace[8056483] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"353.132556ms","start":"2026-01-29T03:16:08.914317Z","end":"2026-01-29T03:16:09.267449Z","steps":["trace[8056483] 'process raft request'  (duration: 141.901886ms)","trace[8056483] 'compare'  (duration: 210.970916ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:16:09.267522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:08.914301Z","time spent":"353.196567ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:750 > 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-29T03:16:09.295673Z","caller":"traceutil/trace.go:171","msg":"trace[62011197] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"380.336193ms","start":"2026-01-29T03:16:08.915316Z","end":"2026-01-29T03:16:09.295652Z","steps":["trace[62011197] 'process raft request'  (duration: 379.745643ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:09.295798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:08.915301Z","time spent":"380.435685ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:753 > 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-29T03:16:09.295999Z","caller":"traceutil/trace.go:171","msg":"trace[181695284] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"380.594118ms","start":"2026-01-29T03:16:08.915389Z","end":"2026-01-29T03:16:09.295983Z","steps":["trace[181695284] 'process raft request'  (duration: 379.768293ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:09.296094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:08.915384Z","time spent":"380.66161ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:752 > 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-29T03:16:09.296291Z","caller":"traceutil/trace.go:171","msg":"trace[1185074518] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"380.261773ms","start":"2026-01-29T03:16:08.916014Z","end":"2026-01-29T03:16:09.296275Z","steps":["trace[1185074518] 'process raft request'  (duration: 379.191543ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:09.29638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:08.916008Z","time spent":"380.327304ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:751 > 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-29T03:16:09.587841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.126234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:16:09.588194Z","caller":"traceutil/trace.go:171","msg":"trace[58266249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:758; }","duration":"179.526641ms","start":"2026-01-29T03:16:09.408644Z","end":"2026-01-29T03:16:09.58817Z","steps":["trace[58266249] 'range keys from in-memory index tree'  (duration: 179.052063ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:21.85418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.08676ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14289248749800420637 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.250\" mod_revision:760 > success:<request_put:<key:\"/registry/masterleases/162.253.55.250\" value_size:67 lease:5065876712945644827 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.250\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T03:16:21.854282Z","caller":"traceutil/trace.go:171","msg":"trace[1533394956] linearizableReadLoop","detail":"{readStateIndex:870; appliedIndex:869; }","duration":"531.220212ms","start":"2026-01-29T03:16:21.323037Z","end":"2026-01-29T03:16:21.854258Z","steps":["trace[1533394956] 'read index received'  (duration: 427.942808ms)","trace[1533394956] 'applied index is now lower than readState.Index'  (duration: 103.276364ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:16:21.854361Z","caller":"traceutil/trace.go:171","msg":"trace[708405912] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"666.233583ms","start":"2026-01-29T03:16:21.188116Z","end":"2026-01-29T03:16:21.85435Z","steps":["trace[708405912] 'process raft request'  (duration: 562.906199ms)","trace[708405912] 'compare'  (duration: 102.703682ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:16:21.854412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:21.188092Z","time spent":"666.291765ms","remote":"127.0.0.1:59494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.250\" mod_revision:760 > success:<request_put:<key:\"/registry/masterleases/162.253.55.250\" value_size:67 lease:5065876712945644827 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.250\" > >"}
{"level":"warn","ts":"2026-01-29T03:16:21.854699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.656529ms","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-29T03:16:21.854737Z","caller":"traceutil/trace.go:171","msg":"trace[798185740] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:839; }","duration":"531.71417ms","start":"2026-01-29T03:16:21.323012Z","end":"2026-01-29T03:16:21.854726Z","steps":["trace[798185740] 'agreement among raft nodes before linearized reading'  (duration: 531.572917ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:21.854766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:21.322999Z","time spent":"531.761361ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-29T03:16:21.854999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.447068ms","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-29T03:16:21.855034Z","caller":"traceutil/trace.go:171","msg":"trace[314114828] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:839; }","duration":"495.502599ms","start":"2026-01-29T03:16:21.359523Z","end":"2026-01-29T03:16:21.855025Z","steps":["trace[314114828] 'agreement among raft nodes before linearized reading'  (duration: 495.415867ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:21.855068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:21.359509Z","time spent":"495.55057ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-29T03:16:21.855288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.108992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:16:21.855321Z","caller":"traceutil/trace.go:171","msg":"trace[409237031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:839; }","duration":"486.151533ms","start":"2026-01-29T03:16:21.369161Z","end":"2026-01-29T03:16:21.855312Z","steps":["trace[409237031] 'agreement among raft nodes before linearized reading'  (duration: 486.105862ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:21.855345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:21.369156Z","time spent":"486.184614ms","remote":"127.0.0.1:59476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-29T03:16:21.855535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.171043ms","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-29T03:16:21.855569Z","caller":"traceutil/trace.go:171","msg":"trace[1088877723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:839; }","duration":"491.233454ms","start":"2026-01-29T03:16:21.364327Z","end":"2026-01-29T03:16:21.855561Z","steps":["trace[1088877723] 'agreement among raft nodes before linearized reading'  (duration: 491.132712ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:21.8556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:21.364322Z","time spent":"491.271595ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-29T03:16:21.855759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.097685ms","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-29T03:16:21.855792Z","caller":"traceutil/trace.go:171","msg":"trace[1947839740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:839; }","duration":"494.140406ms","start":"2026-01-29T03:16:21.361644Z","end":"2026-01-29T03:16:21.855785Z","steps":["trace[1947839740] 'agreement among raft nodes before linearized reading'  (duration: 494.058104ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:21.855821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:21.361639Z","time spent":"494.177226ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-29T03:16:22.416223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.940033ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14289248749800420642 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:835 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T03:16:22.416363Z","caller":"traceutil/trace.go:171","msg":"trace[768710459] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"232.054663ms","start":"2026-01-29T03:16:22.184298Z","end":"2026-01-29T03:16:22.416353Z","steps":["trace[768710459] 'process raft request'  (duration: 232.037673ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:22.416533Z","caller":"traceutil/trace.go:171","msg":"trace[246382438] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"553.220596ms","start":"2026-01-29T03:16:21.863306Z","end":"2026-01-29T03:16:22.416527Z","steps":["trace[246382438] 'process raft request'  (duration: 102.931548ms)","trace[246382438] 'compare'  (duration: 449.667277ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:16:22.41656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:21.86329Z","time spent":"553.255506ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:835 > 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-29T03:16:22.416622Z","caller":"traceutil/trace.go:171","msg":"trace[935069962] linearizableReadLoop","detail":"{readStateIndex:871; appliedIndex:870; }","duration":"553.252888ms","start":"2026-01-29T03:16:21.863364Z","end":"2026-01-29T03:16:22.416617Z","steps":["trace[935069962] 'read index received'  (duration: 102.881607ms)","trace[935069962] 'applied index is now lower than readState.Index'  (duration: 450.370811ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:16:22.416665Z","caller":"traceutil/trace.go:171","msg":"trace[1731862552] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"552.430262ms","start":"2026-01-29T03:16:21.86423Z","end":"2026-01-29T03:16:22.41666Z","steps":["trace[1731862552] 'process raft request'  (duration: 552.051995ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:22.416686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:21.86422Z","time spent":"552.453283ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:834 > 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-29T03:16:22.41674Z","caller":"traceutil/trace.go:171","msg":"trace[2077722850] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"551.379423ms","start":"2026-01-29T03:16:21.865355Z","end":"2026-01-29T03:16:22.416734Z","steps":["trace[2077722850] 'process raft request'  (duration: 550.951154ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:22.416762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:21.865348Z","time spent":"551.400963ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:837 > 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-29T03:16:22.416857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.490082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-01-29T03:16:22.41687Z","caller":"traceutil/trace.go:171","msg":"trace[929105542] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:844; }","duration":"553.502932ms","start":"2026-01-29T03:16:21.863362Z","end":"2026-01-29T03:16:22.416865Z","steps":["trace[929105542] 'agreement among raft nodes before linearized reading'  (duration: 553.447021ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:22.416882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:21.863354Z","time spent":"553.525642ms","remote":"127.0.0.1:59494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "}
{"level":"warn","ts":"2026-01-29T03:16:22.416962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.153823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-29T03:16:22.416929Z","caller":"traceutil/trace.go:171","msg":"trace[678511107] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"550.951215ms","start":"2026-01-29T03:16:21.865946Z","end":"2026-01-29T03:16:22.416897Z","steps":["trace[678511107] 'process raft request'  (duration: 550.375804ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:22.416976Z","caller":"traceutil/trace.go:171","msg":"trace[1034893362] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:844; }","duration":"364.168934ms","start":"2026-01-29T03:16:22.052803Z","end":"2026-01-29T03:16:22.416972Z","steps":["trace[1034893362] 'agreement among raft nodes before linearized reading'  (duration: 364.137773ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:22.416989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:22.052767Z","time spent":"364.219115ms","remote":"127.0.0.1:59572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":15,"response size":29,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T03:16:22.41707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:21.86594Z","time spent":"551.054007ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:836 > 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-29T03:16:23.44624Z","caller":"traceutil/trace.go:171","msg":"trace[456792061] linearizableReadLoop","detail":"{readStateIndex:876; appliedIndex:875; }","duration":"157.489346ms","start":"2026-01-29T03:16:23.288737Z","end":"2026-01-29T03:16:23.446227Z","steps":["trace[456792061] 'read index received'  (duration: 157.380344ms)","trace[456792061] 'applied index is now lower than readState.Index'  (duration: 108.422µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:16:23.44639Z","caller":"traceutil/trace.go:171","msg":"trace[1110613968] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"473.881832ms","start":"2026-01-29T03:16:22.972503Z","end":"2026-01-29T03:16:23.446385Z","steps":["trace[1110613968] 'process raft request'  (duration: 473.649478ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:23.446456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:22.972495Z","time spent":"473.913172ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:838 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-01-29T03:16:23.446565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.842532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:16:23.446584Z","caller":"traceutil/trace.go:171","msg":"trace[64568738] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:845; }","duration":"157.895853ms","start":"2026-01-29T03:16:23.288681Z","end":"2026-01-29T03:16:23.446577Z","steps":["trace[64568738] 'agreement among raft nodes before linearized reading'  (duration: 157.866012ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:23.446667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.440482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-29T03:16:23.446681Z","caller":"traceutil/trace.go:171","msg":"trace[1937871339] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:845; }","duration":"124.478944ms","start":"2026-01-29T03:16:23.322197Z","end":"2026-01-29T03:16:23.446676Z","steps":["trace[1937871339] 'agreement among raft nodes before linearized reading'  (duration: 124.455823ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:24.61039Z","caller":"traceutil/trace.go:171","msg":"trace[1830062575] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"183.780107ms","start":"2026-01-29T03:16:24.426592Z","end":"2026-01-29T03:16:24.610372Z","steps":["trace[1830062575] 'process raft request'  (duration: 183.684965ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:24.610773Z","caller":"traceutil/trace.go:171","msg":"trace[2079407747] linearizableReadLoop","detail":"{readStateIndex:877; appliedIndex:877; }","duration":"183.264628ms","start":"2026-01-29T03:16:24.427501Z","end":"2026-01-29T03:16:24.610765Z","steps":["trace[2079407747] 'read index received'  (duration: 183.261718ms)","trace[2079407747] 'applied index is now lower than readState.Index'  (duration: 2.45µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:16:24.610904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.38827ms","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-29T03:16:24.610929Z","caller":"traceutil/trace.go:171","msg":"trace[1377398934] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:846; }","duration":"183.43245ms","start":"2026-01-29T03:16:24.427491Z","end":"2026-01-29T03:16:24.610923Z","steps":["trace[1377398934] 'agreement among raft nodes before linearized reading'  (duration: 183.316238ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:24.698406Z","caller":"traceutil/trace.go:171","msg":"trace[227157299] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"269.422604ms","start":"2026-01-29T03:16:24.428968Z","end":"2026-01-29T03:16:24.698391Z","steps":["trace[227157299] 'process raft request'  (duration: 262.026701ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:24.698663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.830573ms","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-29T03:16:24.698682Z","caller":"traceutil/trace.go:171","msg":"trace[598784424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:847; }","duration":"268.892024ms","start":"2026-01-29T03:16:24.429785Z","end":"2026-01-29T03:16:24.698677Z","steps":["trace[598784424] 'agreement among raft nodes before linearized reading'  (duration: 268.800363ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:25.751828Z","caller":"traceutil/trace.go:171","msg":"trace[1544479768] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"300.051644ms","start":"2026-01-29T03:16:25.451758Z","end":"2026-01-29T03:16:25.75181Z","steps":["trace[1544479768] 'process raft request'  (duration: 299.960282ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:25.751938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:25.45175Z","time spent":"300.133255ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:845 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-29T03:16:34.179049Z","caller":"traceutil/trace.go:171","msg":"trace[344015088] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"394.290923ms","start":"2026-01-29T03:16:33.784703Z","end":"2026-01-29T03:16:34.178994Z","steps":["trace[344015088] 'process raft request'  (duration: 394.001108ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:34.179212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:33.784694Z","time spent":"394.440088ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:867 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-29T03:16:34.988052Z","caller":"traceutil/trace.go:171","msg":"trace[251195253] linearizableReadLoop","detail":"{readStateIndex:908; appliedIndex:907; }","duration":"253.378096ms","start":"2026-01-29T03:16:34.734656Z","end":"2026-01-29T03:16:34.988034Z","steps":["trace[251195253] 'read index received'  (duration: 253.227643ms)","trace[251195253] 'applied index is now lower than readState.Index'  (duration: 149.453µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:16:34.988158Z","caller":"traceutil/trace.go:171","msg":"trace[1146354742] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"255.432342ms","start":"2026-01-29T03:16:34.732719Z","end":"2026-01-29T03:16:34.988151Z","steps":["trace[1146354742] 'process raft request'  (duration: 255.187228ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:34.988368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.694841ms","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-29T03:16:34.988392Z","caller":"traceutil/trace.go:171","msg":"trace[1150779285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:875; }","duration":"253.738113ms","start":"2026-01-29T03:16:34.734645Z","end":"2026-01-29T03:16:34.988383Z","steps":["trace[1150779285] 'agreement among raft nodes before linearized reading'  (duration: 253.6244ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:34.988641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.644579ms","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-29T03:16:34.988706Z","caller":"traceutil/trace.go:171","msg":"trace[771093328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:875; }","duration":"239.743782ms","start":"2026-01-29T03:16:34.748945Z","end":"2026-01-29T03:16:34.988688Z","steps":["trace[771093328] 'agreement among raft nodes before linearized reading'  (duration: 239.578449ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:35.215419Z","caller":"traceutil/trace.go:171","msg":"trace[1578516831] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"222.209617ms","start":"2026-01-29T03:16:34.993193Z","end":"2026-01-29T03:16:35.215402Z","steps":["trace[1578516831] 'process raft request'  (duration: 148.658137ms)","trace[1578516831] 'compare'  (duration: 73.494209ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:16:36.656244Z","caller":"traceutil/trace.go:171","msg":"trace[252268630] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"472.492938ms","start":"2026-01-29T03:16:36.183728Z","end":"2026-01-29T03:16:36.656221Z","steps":["trace[252268630] 'process raft request'  (duration: 472.404467ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:36.656354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:36.18372Z","time spent":"472.572549ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:873 > 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-29T03:16:36.65665Z","caller":"traceutil/trace.go:171","msg":"trace[2074613059] linearizableReadLoop","detail":"{readStateIndex:912; appliedIndex:912; }","duration":"281.520821ms","start":"2026-01-29T03:16:36.375121Z","end":"2026-01-29T03:16:36.656642Z","steps":["trace[2074613059] 'read index received'  (duration: 281.517981ms)","trace[2074613059] 'applied index is now lower than readState.Index'  (duration: 2.35µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:16:36.656725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.598853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:16:36.65675Z","caller":"traceutil/trace.go:171","msg":"trace[1439734716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:879; }","duration":"281.650143ms","start":"2026-01-29T03:16:36.375094Z","end":"2026-01-29T03:16:36.656744Z","steps":["trace[1439734716] 'agreement among raft nodes before linearized reading'  (duration: 281.607182ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:37.604436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.898873ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14289248749800420746 > lease_revoke:<id:464d9c07bf0c751b>","response":"size:27"}
{"level":"info","ts":"2026-01-29T03:16:37.60451Z","caller":"traceutil/trace.go:171","msg":"trace[218206992] linearizableReadLoop","detail":"{readStateIndex:913; appliedIndex:912; }","duration":"947.810446ms","start":"2026-01-29T03:16:36.656689Z","end":"2026-01-29T03:16:37.604499Z","steps":["trace[218206992] 'read index received'  (duration: 235.851771ms)","trace[218206992] 'applied index is now lower than readState.Index'  (duration: 711.957785ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:16:37.604805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.099035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:16:37.604824Z","caller":"traceutil/trace.go:171","msg":"trace[453027180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:879; }","duration":"946.149356ms","start":"2026-01-29T03:16:36.658667Z","end":"2026-01-29T03:16:37.604817Z","steps":["trace[453027180] 'agreement among raft nodes before linearized reading'  (duration: 946.106985ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:37.604841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:36.658654Z","time spent":"946.183316ms","remote":"127.0.0.1:59478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-29T03:16:37.60485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.456292ms","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-29T03:16:37.604893Z","caller":"traceutil/trace.go:171","msg":"trace[738789789] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:879; }","duration":"960.541044ms","start":"2026-01-29T03:16:36.644341Z","end":"2026-01-29T03:16:37.604882Z","steps":["trace[738789789] 'agreement among raft nodes before linearized reading'  (duration: 960.413062ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:37.604915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:36.644323Z","time spent":"960.588055ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-29T03:16:37.605013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.661547ms","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-29T03:16:37.605032Z","caller":"traceutil/trace.go:171","msg":"trace[571688278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:879; }","duration":"386.704298ms","start":"2026-01-29T03:16:37.218323Z","end":"2026-01-29T03:16:37.605027Z","steps":["trace[571688278] 'agreement among raft nodes before linearized reading'  (duration: 386.622226ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:37.605047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:37.21831Z","time spent":"386.733939ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-29T03:16:37.605118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.182413ms","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-29T03:16:37.605131Z","caller":"traceutil/trace.go:171","msg":"trace[1994819573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:879; }","duration":"568.208004ms","start":"2026-01-29T03:16:37.036919Z","end":"2026-01-29T03:16:37.605127Z","steps":["trace[1994819573] 'agreement among raft nodes before linearized reading'  (duration: 568.168804ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:37.605144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:37.036912Z","time spent":"568.229675ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-29T03:16:37.605193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.5704ms","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-29T03:16:37.605206Z","caller":"traceutil/trace.go:171","msg":"trace[1206230829] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:879; }","duration":"612.635101ms","start":"2026-01-29T03:16:36.992567Z","end":"2026-01-29T03:16:37.605202Z","steps":["trace[1206230829] 'agreement among raft nodes before linearized reading'  (duration: 612.60409ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:37.605219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:36.992551Z","time spent":"612.663882ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-01-29T03:16:37.898913Z","caller":"traceutil/trace.go:171","msg":"trace[1485222062] linearizableReadLoop","detail":"{readStateIndex:917; appliedIndex:914; }","duration":"281.872707ms","start":"2026-01-29T03:16:37.617025Z","end":"2026-01-29T03:16:37.898897Z","steps":["trace[1485222062] 'read index received'  (duration: 55.478866ms)","trace[1485222062] 'applied index is now lower than readState.Index'  (duration: 226.392931ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:16:37.898982Z","caller":"traceutil/trace.go:171","msg":"trace[1348247348] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"290.300629ms","start":"2026-01-29T03:16:37.608676Z","end":"2026-01-29T03:16:37.898977Z","steps":["trace[1348247348] 'process raft request'  (duration: 290.184057ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:37.898987Z","caller":"traceutil/trace.go:171","msg":"trace[907113025] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"290.319378ms","start":"2026-01-29T03:16:37.608648Z","end":"2026-01-29T03:16:37.898968Z","steps":["trace[907113025] 'process raft request'  (duration: 290.091375ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:37.899149Z","caller":"traceutil/trace.go:171","msg":"trace[1668352759] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"285.995881ms","start":"2026-01-29T03:16:37.613147Z","end":"2026-01-29T03:16:37.899143Z","steps":["trace[1668352759] 'process raft request'  (duration: 285.732447ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:37.899237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.202053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:16:37.899258Z","caller":"traceutil/trace.go:171","msg":"trace[648540096] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:883; }","duration":"282.250304ms","start":"2026-01-29T03:16:37.617002Z","end":"2026-01-29T03:16:37.899252Z","steps":["trace[648540096] 'agreement among raft nodes before linearized reading'  (duration: 282.207633ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:37.89937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.968006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:16:37.899383Z","caller":"traceutil/trace.go:171","msg":"trace[1823278235] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:883; }","duration":"127.983427ms","start":"2026-01-29T03:16:37.771396Z","end":"2026-01-29T03:16:37.899379Z","steps":["trace[1823278235] 'agreement among raft nodes before linearized reading'  (duration: 127.958786ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:42.041182Z","caller":"traceutil/trace.go:171","msg":"trace[985408739] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"102.533609ms","start":"2026-01-29T03:16:41.938633Z","end":"2026-01-29T03:16:42.041167Z","steps":["trace[985408739] 'process raft request'  (duration: 102.508289ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:42.041394Z","caller":"traceutil/trace.go:171","msg":"trace[1913737165] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"103.194192ms","start":"2026-01-29T03:16:41.938193Z","end":"2026-01-29T03:16:42.041387Z","steps":["trace[1913737165] 'process raft request'  (duration: 101.477341ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:16:52.258945Z","caller":"traceutil/trace.go:171","msg":"trace[685031644] linearizableReadLoop","detail":"{readStateIndex:999; appliedIndex:998; }","duration":"187.515294ms","start":"2026-01-29T03:16:52.071406Z","end":"2026-01-29T03:16:52.258921Z","steps":["trace[685031644] 'read index received'  (duration: 187.27295ms)","trace[685031644] 'applied index is now lower than readState.Index'  (duration: 241.244µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:16:52.259849Z","caller":"traceutil/trace.go:171","msg":"trace[911819750] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"542.057336ms","start":"2026-01-29T03:16:51.717774Z","end":"2026-01-29T03:16:52.259831Z","steps":["trace[911819750] 'process raft request'  (duration: 540.966756ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:52.259971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:51.717766Z","time spent":"542.127857ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:955 > 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-29T03:16:52.737377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.958161ms","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-29T03:16:52.737422Z","caller":"traceutil/trace.go:171","msg":"trace[1189948442] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:962; }","duration":"666.030724ms","start":"2026-01-29T03:16:52.071379Z","end":"2026-01-29T03:16:52.73741Z","steps":["trace[1189948442] 'agreement among raft nodes before linearized reading'  (duration: 188.958782ms)","trace[1189948442] 'range keys from in-memory index tree'  (duration: 476.96817ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:16:52.737444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:52.071369Z","time spent":"666.069935ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-29T03:16:52.737548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.598838ms","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-29T03:16:52.737561Z","caller":"traceutil/trace.go:171","msg":"trace[1396296446] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:962; }","duration":"648.66703ms","start":"2026-01-29T03:16:52.088889Z","end":"2026-01-29T03:16:52.737556Z","steps":["trace[1396296446] 'agreement among raft nodes before linearized reading'  (duration: 171.483205ms)","trace[1396296446] 'range keys from in-memory index tree'  (duration: 477.148164ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:16:52.737574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:52.08887Z","time spent":"648.700171ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-29T03:16:52.737646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.921536ms","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-29T03:16:52.737659Z","caller":"traceutil/trace.go:171","msg":"trace[12776654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:962; }","duration":"632.984997ms","start":"2026-01-29T03:16:52.104669Z","end":"2026-01-29T03:16:52.737654Z","steps":["trace[12776654] 'agreement among raft nodes before linearized reading'  (duration: 155.715781ms)","trace[12776654] 'range keys from in-memory index tree'  (duration: 477.235846ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:16:52.73767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:52.104659Z","time spent":"633.009118ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-29T03:16:52.737758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.696295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:16:52.737773Z","caller":"traceutil/trace.go:171","msg":"trace[1309196388] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:962; }","duration":"363.743675ms","start":"2026-01-29T03:16:52.374024Z","end":"2026-01-29T03:16:52.737768Z","steps":["trace[1309196388] 'range keys from in-memory index tree'  (duration: 363.639264ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:52.737783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:52.374006Z","time spent":"363.774367ms","remote":"127.0.0.1:59476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-29T03:16:53.326913Z","caller":"traceutil/trace.go:171","msg":"trace[2075342760] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1000; }","duration":"549.375707ms","start":"2026-01-29T03:16:52.777513Z","end":"2026-01-29T03:16:53.326888Z","steps":["trace[2075342760] 'read index received'  (duration: 49.566594ms)","trace[2075342760] 'applied index is now lower than readState.Index'  (duration: 499.808273ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:16:53.327201Z","caller":"traceutil/trace.go:171","msg":"trace[2059965948] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"585.225745ms","start":"2026-01-29T03:16:52.741964Z","end":"2026-01-29T03:16:53.327189Z","steps":["trace[2059965948] 'process raft request'  (duration: 584.669136ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:53.327297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:52.741952Z","time spent":"585.277936ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:959 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-29T03:16:53.327471Z","caller":"traceutil/trace.go:171","msg":"trace[537441562] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"584.396941ms","start":"2026-01-29T03:16:52.743064Z","end":"2026-01-29T03:16:53.327461Z","steps":["trace[537441562] 'process raft request'  (duration: 583.719088ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:53.32752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:52.74305Z","time spent":"584.442522ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:956 > 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-29T03:16:53.327639Z","caller":"traceutil/trace.go:171","msg":"trace[2020875909] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"564.377199ms","start":"2026-01-29T03:16:52.763253Z","end":"2026-01-29T03:16:53.32763Z","steps":["trace[2020875909] 'process raft request'  (duration: 563.570214ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:53.327686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:52.763236Z","time spent":"564.423559ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:958 > 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\" > >"}
{"level":"warn","ts":"2026-01-29T03:16:53.3279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.383615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-01-29T03:16:53.327961Z","caller":"traceutil/trace.go:171","msg":"trace[258295726] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:966; }","duration":"550.468538ms","start":"2026-01-29T03:16:52.777482Z","end":"2026-01-29T03:16:53.327951Z","steps":["trace[258295726] 'agreement among raft nodes before linearized reading'  (duration: 550.333285ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:53.327995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:52.777472Z","time spent":"550.516538ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-01-29T03:16:53.358034Z","caller":"traceutil/trace.go:171","msg":"trace[153465669] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"316.234469ms","start":"2026-01-29T03:16:53.041769Z","end":"2026-01-29T03:16:53.358003Z","steps":["trace[153465669] 'process raft request'  (duration: 316.001225ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:53.358037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.629204ms","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:534"}
{"level":"info","ts":"2026-01-29T03:16:53.358152Z","caller":"traceutil/trace.go:171","msg":"trace[2058391961] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:967; }","duration":"168.787668ms","start":"2026-01-29T03:16:53.189341Z","end":"2026-01-29T03:16:53.358128Z","steps":["trace[2058391961] 'agreement among raft nodes before linearized reading'  (duration: 168.536933ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:53.358218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:53.041648Z","time spent":"316.459024ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:911 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-01-29T03:16:55.668815Z","caller":"traceutil/trace.go:171","msg":"trace[38570122] linearizableReadLoop","detail":"{readStateIndex:1029; appliedIndex:1028; }","duration":"324.175632ms","start":"2026-01-29T03:16:55.344621Z","end":"2026-01-29T03:16:55.668796Z","steps":["trace[38570122] 'read index received'  (duration: 15.111403ms)","trace[38570122] 'applied index is now lower than readState.Index'  (duration: 309.063549ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T03:16:55.669628Z","caller":"traceutil/trace.go:171","msg":"trace[187544763] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"327.330409ms","start":"2026-01-29T03:16:55.341637Z","end":"2026-01-29T03:16:55.668967Z","steps":["trace[187544763] 'process raft request'  (duration: 230.141275ms)","trace[187544763] 'compare'  (duration: 96.905599ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T03:16:55.669952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:55.34162Z","time spent":"328.042421ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:964 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-01-29T03:16:55.670295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.668599ms","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-29T03:16:55.670337Z","caller":"traceutil/trace.go:171","msg":"trace[1336106845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:992; }","duration":"325.733761ms","start":"2026-01-29T03:16:55.344593Z","end":"2026-01-29T03:16:55.670327Z","steps":["trace[1336106845] 'agreement among raft nodes before linearized reading'  (duration: 325.611979ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:55.67037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:55.344583Z","time spent":"325.779631ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-29T03:16:55.676025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.859935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:16:55.676089Z","caller":"traceutil/trace.go:171","msg":"trace[1726412176] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:993; }","duration":"303.969007ms","start":"2026-01-29T03:16:55.372105Z","end":"2026-01-29T03:16:55.676074Z","steps":["trace[1726412176] 'agreement among raft nodes before linearized reading'  (duration: 303.854785ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:55.676118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T03:16:55.372093Z","time spent":"304.019908ms","remote":"127.0.0.1:59476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-29T03:16:55.676445Z","caller":"traceutil/trace.go:171","msg":"trace[144668510] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"279.073968ms","start":"2026-01-29T03:16:55.397358Z","end":"2026-01-29T03:16:55.676432Z","steps":["trace[144668510] 'process raft request'  (duration: 272.821325ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T03:16:55.680655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.358479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T03:16:55.680698Z","caller":"traceutil/trace.go:171","msg":"trace[1989699514] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:993; }","duration":"112.434149ms","start":"2026-01-29T03:16:55.568253Z","end":"2026-01-29T03:16:55.680687Z","steps":["trace[1989699514] 'agreement among raft nodes before linearized reading'  (duration: 112.373168ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:20:00.045995Z","caller":"traceutil/trace.go:171","msg":"trace[558591162] transaction","detail":"{read_only:false; response_revision:1777; number_of_response:1; }","duration":"150.980479ms","start":"2026-01-29T03:19:59.894986Z","end":"2026-01-29T03:20:00.045966Z","steps":["trace[558591162] 'process raft request'  (duration: 150.859077ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T03:20:30.886129Z","caller":"traceutil/trace.go:171","msg":"trace[981250157] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"102.143139ms","start":"2026-01-29T03:20:30.783965Z","end":"2026-01-29T03:20:30.886108Z","steps":["trace[981250157] 'process raft request'  (duration: 26.019086ms)","trace[981250157] 'compare'  (duration: 75.801777ms)"],"step_count":2}