{"level":"warn","ts":"2026-01-29T19:05:46.507322Z","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-29T19:05:46.507576Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.131: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://199.204.45.131:2380","--initial-cluster=instance=https://199.204.45.131:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.131:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.131: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-29T19:05:46.507735Z","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-29T19:05:46.507797Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.131:2380"]}
{"level":"info","ts":"2026-01-29T19:05:46.507899Z","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-29T19:05:46.508563Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"]}
{"level":"info","ts":"2026-01-29T19:05:46.514399Z","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://199.204.45.131:2380"],"listen-peer-urls":["https://199.204.45.131:2380"],"advertise-client-urls":["https://199.204.45.131:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.131: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-29T19:05:46.522794Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.205625ms"}
{"level":"info","ts":"2026-01-29T19:05:46.531224Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2fdf33955ed9ec6c","cluster-id":"e3dd6b4ed8cb907a"}
{"level":"info","ts":"2026-01-29T19:05:46.531278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=()"}
{"level":"info","ts":"2026-01-29T19:05:46.531297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became follower at term 0"}
{"level":"info","ts":"2026-01-29T19:05:46.531324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2fdf33955ed9ec6c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-29T19:05:46.531335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became follower at term 1"}
{"level":"info","ts":"2026-01-29T19:05:46.531362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=(3449532556223573100)"}
{"level":"warn","ts":"2026-01-29T19:05:46.538303Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-29T19:05:46.545617Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-29T19:05:46.548498Z","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-29T19:05:46.552316Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2fdf33955ed9ec6c","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-29T19:05:46.552634Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2fdf33955ed9ec6c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-29T19:05:46.552743Z","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-29T19:05:46.552772Z","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-29T19:05:46.552778Z","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-29T19:05:46.553199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=(3449532556223573100)"}
{"level":"info","ts":"2026-01-29T19:05:46.553271Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e3dd6b4ed8cb907a","local-member-id":"2fdf33955ed9ec6c","added-peer-id":"2fdf33955ed9ec6c","added-peer-peer-urls":["https://199.204.45.131:2380"]}
{"level":"info","ts":"2026-01-29T19:05:46.55933Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.131:2380"}
{"level":"info","ts":"2026-01-29T19:05:46.561087Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.131:2380"}
{"level":"info","ts":"2026-01-29T19:05:46.559116Z","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-29T19:05:46.56569Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2fdf33955ed9ec6c","initial-advertise-peer-urls":["https://199.204.45.131:2380"],"listen-peer-urls":["https://199.204.45.131:2380"],"advertise-client-urls":["https://199.204.45.131:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-29T19:05:46.565743Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-29T19:05:46.831887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c is starting a new election at term 1"}
{"level":"info","ts":"2026-01-29T19:05:46.831928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-29T19:05:46.831953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c received MsgPreVoteResp from 2fdf33955ed9ec6c at term 1"}
{"level":"info","ts":"2026-01-29T19:05:46.831965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became candidate at term 2"}
{"level":"info","ts":"2026-01-29T19:05:46.83197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c received MsgVoteResp from 2fdf33955ed9ec6c at term 2"}
{"level":"info","ts":"2026-01-29T19:05:46.831979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became leader at term 2"}
{"level":"info","ts":"2026-01-29T19:05:46.83199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2fdf33955ed9ec6c elected leader 2fdf33955ed9ec6c at term 2"}
{"level":"info","ts":"2026-01-29T19:05:46.833731Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2fdf33955ed9ec6c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.131:2379]}","request-path":"/0/members/2fdf33955ed9ec6c/attributes","cluster-id":"e3dd6b4ed8cb907a","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-29T19:05:46.833757Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-29T19:05:46.834003Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T19:05:46.8358Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-29T19:05:46.836019Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e3dd6b4ed8cb907a","local-member-id":"2fdf33955ed9ec6c","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T19:05:46.83607Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T19:05:46.836091Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T19:05:46.836099Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-29T19:05:46.846451Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.131:2379"}
{"level":"info","ts":"2026-01-29T19:05:46.846676Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-29T19:05:46.846691Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-29T19:06:04.468206Z","caller":"traceutil/trace.go:171","msg":"trace[1570704351] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"439.367063ms","start":"2026-01-29T19:06:04.028817Z","end":"2026-01-29T19:06:04.468184Z","steps":["trace[1570704351] 'process raft request'  (duration: 439.22884ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:04.46878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:06:04.028779Z","time spent":"439.509286ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:368 > 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-29T19:06:19.389391Z","caller":"traceutil/trace.go:171","msg":"trace[1665283539] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:490; }","duration":"184.420909ms","start":"2026-01-29T19:06:19.204954Z","end":"2026-01-29T19:06:19.389375Z","steps":["trace[1665283539] 'read index received'  (duration: 184.288886ms)","trace[1665283539] 'applied index is now lower than readState.Index'  (duration: 131.333µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:06:19.389477Z","caller":"traceutil/trace.go:171","msg":"trace[762567172] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"264.186692ms","start":"2026-01-29T19:06:19.125285Z","end":"2026-01-29T19:06:19.389472Z","steps":["trace[762567172] 'process raft request'  (duration: 263.985128ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:19.389799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.831027ms","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-29T19:06:19.389835Z","caller":"traceutil/trace.go:171","msg":"trace[875529931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:473; }","duration":"184.898649ms","start":"2026-01-29T19:06:19.204928Z","end":"2026-01-29T19:06:19.389827Z","steps":["trace[875529931] 'agreement among raft nodes before linearized reading'  (duration: 184.802637ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:19.389834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.135502ms","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-29T19:06:19.389882Z","caller":"traceutil/trace.go:171","msg":"trace[1349361680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:473; }","duration":"180.207544ms","start":"2026-01-29T19:06:19.209662Z","end":"2026-01-29T19:06:19.389869Z","steps":["trace[1349361680] 'agreement among raft nodes before linearized reading'  (duration: 179.897787ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:20.655655Z","caller":"traceutil/trace.go:171","msg":"trace[1285612545] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:496; }","duration":"114.562447ms","start":"2026-01-29T19:06:20.541066Z","end":"2026-01-29T19:06:20.655629Z","steps":["trace[1285612545] 'read index received'  (duration: 114.535036ms)","trace[1285612545] 'applied index is now lower than readState.Index'  (duration: 26.111µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:06:20.655937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.847472ms","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-29T19:06:20.655991Z","caller":"traceutil/trace.go:171","msg":"trace[271354036] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:477; }","duration":"114.940784ms","start":"2026-01-29T19:06:20.54104Z","end":"2026-01-29T19:06:20.655981Z","steps":["trace[271354036] 'agreement among raft nodes before linearized reading'  (duration: 114.711929ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:20.881704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.978425ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126946093 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.131\" mod_revision:419 > success:<request_put:<key:\"/registry/masterleases/199.204.45.131\" value_size:67 lease:7812791025272170282 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.131\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T19:06:20.881859Z","caller":"traceutil/trace.go:171","msg":"trace[1245005124] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"222.979408ms","start":"2026-01-29T19:06:20.658869Z","end":"2026-01-29T19:06:20.881848Z","steps":["trace[1245005124] 'process raft request'  (duration: 222.936637ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:20.881894Z","caller":"traceutil/trace.go:171","msg":"trace[718244124] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"225.622361ms","start":"2026-01-29T19:06:20.656238Z","end":"2026-01-29T19:06:20.88186Z","steps":["trace[718244124] 'process raft request'  (duration: 107.315569ms)","trace[718244124] 'compare'  (duration: 117.892884ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:06:25.624948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.328759ms","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-29T19:06:25.625028Z","caller":"traceutil/trace.go:171","msg":"trace[446135307] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:491; }","duration":"197.451573ms","start":"2026-01-29T19:06:25.427555Z","end":"2026-01-29T19:06:25.625007Z","steps":["trace[446135307] 'range keys from in-memory index tree'  (duration: 197.090424ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:25.625246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.04769ms","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-29T19:06:25.625274Z","caller":"traceutil/trace.go:171","msg":"trace[1337856544] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:491; }","duration":"177.124442ms","start":"2026-01-29T19:06:25.448141Z","end":"2026-01-29T19:06:25.625266Z","steps":["trace[1337856544] 'range keys from in-memory index tree'  (duration: 176.934368ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:25.625581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.415126ms","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-29T19:06:25.627751Z","caller":"traceutil/trace.go:171","msg":"trace[1622215485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:491; }","duration":"172.612609ms","start":"2026-01-29T19:06:25.455113Z","end":"2026-01-29T19:06:25.627726Z","steps":["trace[1622215485] 'range keys from in-memory index tree'  (duration: 170.260862ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:28.443852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.140231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-01-29T19:06:28.443942Z","caller":"traceutil/trace.go:171","msg":"trace[1587455478] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:510; }","duration":"588.263333ms","start":"2026-01-29T19:06:27.855658Z","end":"2026-01-29T19:06:28.443921Z","steps":["trace[1587455478] 'range keys from in-memory index tree'  (duration: 588.048049ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:28.443995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:06:27.855642Z","time spent":"588.341255ms","remote":"127.0.0.1:36358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-01-29T19:06:28.444447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.775604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:06:28.444483Z","caller":"traceutil/trace.go:171","msg":"trace[1968694531] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"404.871946ms","start":"2026-01-29T19:06:28.039599Z","end":"2026-01-29T19:06:28.444471Z","steps":["trace[1968694531] 'range keys from in-memory index tree'  (duration: 404.676891ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:28.444585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:06:28.039581Z","time spent":"404.995948ms","remote":"127.0.0.1:34854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-29T19:06:29.809953Z","caller":"traceutil/trace.go:171","msg":"trace[2059771300] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"170.480756ms","start":"2026-01-29T19:06:29.639442Z","end":"2026-01-29T19:06:29.809923Z","steps":["trace[2059771300] 'process raft request'  (duration: 155.176957ms)","trace[2059771300] 'compare'  (duration: 15.056824ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:06:29.812557Z","caller":"traceutil/trace.go:171","msg":"trace[373905063] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:560; }","duration":"105.718667ms","start":"2026-01-29T19:06:29.706827Z","end":"2026-01-29T19:06:29.812545Z","steps":["trace[373905063] 'read index received'  (duration: 87.801005ms)","trace[373905063] 'applied index is now lower than readState.Index'  (duration: 17.916852ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:06:29.812724Z","caller":"traceutil/trace.go:171","msg":"trace[300797046] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"109.602665ms","start":"2026-01-29T19:06:29.703112Z","end":"2026-01-29T19:06:29.812715Z","steps":["trace[300797046] 'process raft request'  (duration: 109.37076ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:29.81296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.118185ms","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-29T19:06:29.812992Z","caller":"traceutil/trace.go:171","msg":"trace[1570712329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:542; }","duration":"106.179605ms","start":"2026-01-29T19:06:29.706804Z","end":"2026-01-29T19:06:29.812983Z","steps":["trace[1570712329] 'agreement among raft nodes before linearized reading'  (duration: 106.051963ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:30.662313Z","caller":"traceutil/trace.go:171","msg":"trace[2065130518] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"113.767671ms","start":"2026-01-29T19:06:30.54852Z","end":"2026-01-29T19:06:30.662288Z","steps":["trace[2065130518] 'process raft request'  (duration: 42.798975ms)","trace[2065130518] 'compare'  (duration: 70.490105ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:06:30.902091Z","caller":"traceutil/trace.go:171","msg":"trace[1518082820] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"168.568978ms","start":"2026-01-29T19:06:30.733487Z","end":"2026-01-29T19:06:30.902056Z","steps":["trace[1518082820] 'process raft request'  (duration: 95.620203ms)","trace[1518082820] 'compare'  (duration: 72.73171ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:06:31.263376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.886348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"}
{"level":"info","ts":"2026-01-29T19:06:31.26344Z","caller":"traceutil/trace.go:171","msg":"trace[163672286] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:567; }","duration":"142.011061ms","start":"2026-01-29T19:06:31.121414Z","end":"2026-01-29T19:06:31.263425Z","steps":["trace[163672286] 'range keys from in-memory index tree'  (duration: 141.732445ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:38.997022Z","caller":"traceutil/trace.go:171","msg":"trace[1746155386] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"114.428283ms","start":"2026-01-29T19:06:38.88258Z","end":"2026-01-29T19:06:38.997008Z","steps":["trace[1746155386] 'read index received'  (duration: 48.125353ms)","trace[1746155386] 'applied index is now lower than readState.Index'  (duration: 66.30069ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:06:38.99719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.581896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-wdftp\" ","response":"range_response_count:1 size:4733"}
{"level":"info","ts":"2026-01-29T19:06:38.997224Z","caller":"traceutil/trace.go:171","msg":"trace[309348032] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-wdftp; range_end:; response_count:1; response_revision:640; }","duration":"114.653678ms","start":"2026-01-29T19:06:38.882563Z","end":"2026-01-29T19:06:38.997217Z","steps":["trace[309348032] 'agreement among raft nodes before linearized reading'  (duration: 114.519645ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:38.997244Z","caller":"traceutil/trace.go:171","msg":"trace[1407050764] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"114.703959ms","start":"2026-01-29T19:06:38.882536Z","end":"2026-01-29T19:06:38.99724Z","steps":["trace[1407050764] 'process raft request'  (duration: 114.432264ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:38.997178Z","caller":"traceutil/trace.go:171","msg":"trace[1186510763] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"116.360103ms","start":"2026-01-29T19:06:38.8808Z","end":"2026-01-29T19:06:38.99716Z","steps":["trace[1186510763] 'process raft request'  (duration: 116.026616ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:39.178911Z","caller":"traceutil/trace.go:171","msg":"trace[1033546961] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"169.163491ms","start":"2026-01-29T19:06:39.009733Z","end":"2026-01-29T19:06:39.178897Z","steps":["trace[1033546961] 'process raft request'  (duration: 169.073899ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:39.273397Z","caller":"traceutil/trace.go:171","msg":"trace[1868854323] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"261.276924ms","start":"2026-01-29T19:06:39.012106Z","end":"2026-01-29T19:06:39.273383Z","steps":["trace[1868854323] 'process raft request'  (duration: 261.240433ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:39.273648Z","caller":"traceutil/trace.go:171","msg":"trace[1384943250] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"262.735452ms","start":"2026-01-29T19:06:39.010908Z","end":"2026-01-29T19:06:39.273643Z","steps":["trace[1384943250] 'process raft request'  (duration: 262.333384ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:39.563781Z","caller":"traceutil/trace.go:171","msg":"trace[427446447] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"109.557544ms","start":"2026-01-29T19:06:39.45421Z","end":"2026-01-29T19:06:39.563768Z","steps":["trace[427446447] 'process raft request'  (duration: 101.615034ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:39.56517Z","caller":"traceutil/trace.go:171","msg":"trace[67550044] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"110.712879ms","start":"2026-01-29T19:06:39.45445Z","end":"2026-01-29T19:06:39.565163Z","steps":["trace[67550044] 'process raft request'  (duration: 110.674308ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:46.125565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.121961ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126946486 > lease_revoke:<id:6c6c9c0b25b527b6>","response":"size:28"}
{"level":"info","ts":"2026-01-29T19:06:46.125726Z","caller":"traceutil/trace.go:171","msg":"trace[1435533551] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"166.542837ms","start":"2026-01-29T19:06:45.959115Z","end":"2026-01-29T19:06:46.125657Z","steps":["trace[1435533551] 'read index received'  (duration: 51.621µs)","trace[1435533551] 'applied index is now lower than readState.Index'  (duration: 166.489526ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:06:46.12587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.298374ms","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-29T19:06:46.125964Z","caller":"traceutil/trace.go:171","msg":"trace[1182752306] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:681; }","duration":"265.404706ms","start":"2026-01-29T19:06:45.860545Z","end":"2026-01-29T19:06:46.12595Z","steps":["trace[1182752306] 'range keys from in-memory index tree'  (duration: 265.283414ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:46.126224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.098739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-01-29T19:06:46.126268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.621755ms","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-29T19:06:46.126293Z","caller":"traceutil/trace.go:171","msg":"trace[407409361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:681; }","duration":"151.662076ms","start":"2026-01-29T19:06:45.974624Z","end":"2026-01-29T19:06:46.126286Z","steps":["trace[407409361] 'agreement among raft nodes before linearized reading'  (duration: 151.561434ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:46.126475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.271938ms","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-29T19:06:46.126492Z","caller":"traceutil/trace.go:171","msg":"trace[1490846647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:681; }","duration":"150.301708ms","start":"2026-01-29T19:06:45.976185Z","end":"2026-01-29T19:06:46.126487Z","steps":["trace[1490846647] 'agreement among raft nodes before linearized reading'  (duration: 150.230667ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:46.126269Z","caller":"traceutil/trace.go:171","msg":"trace[1829067605] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:681; }","duration":"167.18935ms","start":"2026-01-29T19:06:45.959069Z","end":"2026-01-29T19:06:46.126259Z","steps":["trace[1829067605] 'agreement among raft nodes before linearized reading'  (duration: 167.028197ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:46.602592Z","caller":"traceutil/trace.go:171","msg":"trace[1295574045] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"472.812219ms","start":"2026-01-29T19:06:46.129748Z","end":"2026-01-29T19:06:46.60256Z","steps":["trace[1295574045] 'process raft request'  (duration: 472.637246ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:46.60272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:06:46.129675Z","time spent":"472.972072ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:678 > 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-29T19:06:47.566335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.840888ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126946490 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:677 > 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-29T19:06:47.566519Z","caller":"traceutil/trace.go:171","msg":"trace[1889261047] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:706; }","duration":"1.435864429s","start":"2026-01-29T19:06:46.13064Z","end":"2026-01-29T19:06:47.566505Z","steps":["trace[1889261047] 'read index received'  (duration: 471.8439ms)","trace[1889261047] 'applied index is now lower than readState.Index'  (duration: 964.019299ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:06:47.566737Z","caller":"traceutil/trace.go:171","msg":"trace[1859822928] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"1.436159825s","start":"2026-01-29T19:06:46.130565Z","end":"2026-01-29T19:06:47.566725Z","steps":["trace[1859822928] 'process raft request'  (duration: 1.245865907s)","trace[1859822928] 'compare'  (duration: 189.614404ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:06:47.566818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:06:46.13055Z","time spent":"1.436220707s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:677 > 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-29T19:06:47.566976Z","caller":"traceutil/trace.go:171","msg":"trace[1973146007] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"1.434756576s","start":"2026-01-29T19:06:46.132211Z","end":"2026-01-29T19:06:47.566967Z","steps":["trace[1973146007] 'process raft request'  (duration: 1.434200635s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:47.567344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:06:46.132204Z","time spent":"1.434792697s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:679 > 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-29T19:06:47.567468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.436830268s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:06:47.567494Z","caller":"traceutil/trace.go:171","msg":"trace[280988928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:684; }","duration":"1.436855059s","start":"2026-01-29T19:06:46.13063Z","end":"2026-01-29T19:06:47.567485Z","steps":["trace[280988928] 'agreement among raft nodes before linearized reading'  (duration: 1.436811318s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:47.567522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:06:46.130607Z","time spent":"1.43690909s","remote":"127.0.0.1:34858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-29T19:06:47.56773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.2645ms","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-29T19:06:47.567756Z","caller":"traceutil/trace.go:171","msg":"trace[427961311] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:684; }","duration":"766.325012ms","start":"2026-01-29T19:06:46.801423Z","end":"2026-01-29T19:06:47.567749Z","steps":["trace[427961311] 'agreement among raft nodes before linearized reading'  (duration: 766.22774ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:06:47.567782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:06:46.801405Z","time spent":"766.370253ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-29T19:06:47.568071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.557769ms","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-29T19:06:47.568107Z","caller":"traceutil/trace.go:171","msg":"trace[2022418530] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:684; }","duration":"269.638212ms","start":"2026-01-29T19:06:47.298459Z","end":"2026-01-29T19:06:47.568097Z","steps":["trace[2022418530] 'agreement among raft nodes before linearized reading'  (duration: 269.534019ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:47.771285Z","caller":"traceutil/trace.go:171","msg":"trace[2059009742] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"196.970762ms","start":"2026-01-29T19:06:47.574296Z","end":"2026-01-29T19:06:47.771267Z","steps":["trace[2059009742] 'process raft request'  (duration: 196.87047ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:47.775485Z","caller":"traceutil/trace.go:171","msg":"trace[933730445] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:710; }","duration":"197.443442ms","start":"2026-01-29T19:06:47.578027Z","end":"2026-01-29T19:06:47.775471Z","steps":["trace[933730445] 'read index received'  (duration: 193.682236ms)","trace[933730445] 'applied index is now lower than readState.Index'  (duration: 3.760446ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:06:47.77558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.540084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:06:47.775606Z","caller":"traceutil/trace.go:171","msg":"trace[962000556] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:686; }","duration":"197.595555ms","start":"2026-01-29T19:06:47.578003Z","end":"2026-01-29T19:06:47.775598Z","steps":["trace[962000556] 'agreement among raft nodes before linearized reading'  (duration: 197.522253ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:06:47.775878Z","caller":"traceutil/trace.go:171","msg":"trace[363305894] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"201.037524ms","start":"2026-01-29T19:06:47.574831Z","end":"2026-01-29T19:06:47.775869Z","steps":["trace[363305894] 'process raft request'  (duration: 200.572685ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:08.539644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.352701ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126946683 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:743 > 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-29T19:07:08.539745Z","caller":"traceutil/trace.go:171","msg":"trace[1739575456] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:776; }","duration":"499.614086ms","start":"2026-01-29T19:07:08.040116Z","end":"2026-01-29T19:07:08.539731Z","steps":["trace[1739575456] 'read index received'  (duration: 82.080441ms)","trace[1739575456] 'applied index is now lower than readState.Index'  (duration: 417.532655ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:07:08.539844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.706829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:07:08.539872Z","caller":"traceutil/trace.go:171","msg":"trace[492220609] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:748; }","duration":"499.77683ms","start":"2026-01-29T19:07:08.040085Z","end":"2026-01-29T19:07:08.539862Z","steps":["trace[492220609] 'agreement among raft nodes before linearized reading'  (duration: 499.688168ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:08.539904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:08.040068Z","time spent":"499.82868ms","remote":"127.0.0.1:34854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-29T19:07:08.540086Z","caller":"traceutil/trace.go:171","msg":"trace[1335635224] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"550.72409ms","start":"2026-01-29T19:07:07.98935Z","end":"2026-01-29T19:07:08.540074Z","steps":["trace[1335635224] 'process raft request'  (duration: 132.870209ms)","trace[1335635224] 'compare'  (duration: 417.110166ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:07:08.540139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:07.989333Z","time spent":"550.77862ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:743 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-29T19:07:08.887396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.633301ms","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-29T19:07:08.887467Z","caller":"traceutil/trace.go:171","msg":"trace[1958717044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:748; }","duration":"141.765513ms","start":"2026-01-29T19:07:08.745685Z","end":"2026-01-29T19:07:08.887451Z","steps":["trace[1958717044] 'range keys from in-memory index tree'  (duration: 141.061059ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:07:09.523089Z","caller":"traceutil/trace.go:171","msg":"trace[2090905433] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:777; }","duration":"166.974078ms","start":"2026-01-29T19:07:09.356088Z","end":"2026-01-29T19:07:09.523062Z","steps":["trace[2090905433] 'read index received'  (duration: 166.787545ms)","trace[2090905433] 'applied index is now lower than readState.Index'  (duration: 185.623µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:07:09.523442Z","caller":"traceutil/trace.go:171","msg":"trace[105063664] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"632.556496ms","start":"2026-01-29T19:07:08.890869Z","end":"2026-01-29T19:07:09.523425Z","steps":["trace[105063664] 'process raft request'  (duration: 632.063067ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:09.523579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:08.890845Z","time spent":"632.638298ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:744 > 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-29T19:07:09.523856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.771883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:07:09.523923Z","caller":"traceutil/trace.go:171","msg":"trace[1256261478] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:749; }","duration":"167.860585ms","start":"2026-01-29T19:07:09.356031Z","end":"2026-01-29T19:07:09.523892Z","steps":["trace[1256261478] 'agreement among raft nodes before linearized reading'  (duration: 167.778474ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:07:14.845011Z","caller":"traceutil/trace.go:171","msg":"trace[1665708006] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"276.14602ms","start":"2026-01-29T19:07:14.568847Z","end":"2026-01-29T19:07:14.844993Z","steps":["trace[1665708006] 'process raft request'  (duration: 276.006577ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:07:15.753841Z","caller":"traceutil/trace.go:171","msg":"trace[761225703] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"177.716339ms","start":"2026-01-29T19:07:15.576105Z","end":"2026-01-29T19:07:15.753822Z","steps":["trace[761225703] 'process raft request'  (duration: 177.527255ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:15.959378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.570237ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126946742 > lease_revoke:<id:6c6c9c0b25b5293c>","response":"size:28"}
{"level":"info","ts":"2026-01-29T19:07:15.95947Z","caller":"traceutil/trace.go:171","msg":"trace[571944556] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:797; }","duration":"237.215986ms","start":"2026-01-29T19:07:15.72224Z","end":"2026-01-29T19:07:15.959456Z","steps":["trace[571944556] 'read index received'  (duration: 32.239593ms)","trace[571944556] 'applied index is now lower than readState.Index'  (duration: 204.975253ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:07:15.959654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.40512ms","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-29T19:07:15.959675Z","caller":"traceutil/trace.go:171","msg":"trace[56561291] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:767; }","duration":"237.462731ms","start":"2026-01-29T19:07:15.722203Z","end":"2026-01-29T19:07:15.959666Z","steps":["trace[56561291] 'agreement among raft nodes before linearized reading'  (duration: 237.334619ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:15.959912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.755202ms","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-29T19:07:15.959962Z","caller":"traceutil/trace.go:171","msg":"trace[1894773814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:767; }","duration":"194.839735ms","start":"2026-01-29T19:07:15.76511Z","end":"2026-01-29T19:07:15.95995Z","steps":["trace[1894773814] 'agreement among raft nodes before linearized reading'  (duration: 194.697281ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:07:21.851018Z","caller":"traceutil/trace.go:171","msg":"trace[462823900] transaction","detail":"{read_only:false; number_of_response:0; response_revision:783; }","duration":"108.633231ms","start":"2026-01-29T19:07:21.742364Z","end":"2026-01-29T19:07:21.850997Z","steps":["trace[462823900] 'process raft request'  (duration: 108.532279ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:24.52601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.273637ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126946908 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:764 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T19:07:24.526092Z","caller":"traceutil/trace.go:171","msg":"trace[558956273] linearizableReadLoop","detail":"{readStateIndex:877; appliedIndex:876; }","duration":"364.29662ms","start":"2026-01-29T19:07:24.161776Z","end":"2026-01-29T19:07:24.526073Z","steps":["trace[558956273] 'read index received'  (duration: 18.83999ms)","trace[558956273] 'applied index is now lower than readState.Index'  (duration: 345.45591ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:07:24.526239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.459743ms","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-29T19:07:24.526277Z","caller":"traceutil/trace.go:171","msg":"trace[1984165291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:843; }","duration":"364.504124ms","start":"2026-01-29T19:07:24.161754Z","end":"2026-01-29T19:07:24.526258Z","steps":["trace[1984165291] 'agreement among raft nodes before linearized reading'  (duration: 364.358051ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:24.526307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:24.161745Z","time spent":"364.555916ms","remote":"127.0.0.1:36486","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-29T19:07:24.526552Z","caller":"traceutil/trace.go:171","msg":"trace[1937256350] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"368.583685ms","start":"2026-01-29T19:07:24.157961Z","end":"2026-01-29T19:07:24.526544Z","steps":["trace[1937256350] 'process raft request'  (duration: 22.693725ms)","trace[1937256350] 'compare'  (duration: 345.185885ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:07:24.526608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:24.157944Z","time spent":"368.643626ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:764 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-01-29T19:07:25.036271Z","caller":"traceutil/trace.go:171","msg":"trace[286544058] linearizableReadLoop","detail":"{readStateIndex:878; appliedIndex:877; }","duration":"333.986925ms","start":"2026-01-29T19:07:24.702253Z","end":"2026-01-29T19:07:25.03624Z","steps":["trace[286544058] 'read index received'  (duration: 333.855492ms)","trace[286544058] 'applied index is now lower than readState.Index'  (duration: 130.553µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:07:25.036374Z","caller":"traceutil/trace.go:171","msg":"trace[1059568884] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"506.722956ms","start":"2026-01-29T19:07:24.529625Z","end":"2026-01-29T19:07:25.036348Z","steps":["trace[1059568884] 'process raft request'  (duration: 506.46937ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:25.036493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.16043ms","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":"warn","ts":"2026-01-29T19:07:25.036511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:24.529611Z","time spent":"506.833718ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:834 > 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-29T19:07:25.036523Z","caller":"traceutil/trace.go:171","msg":"trace[265390727] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:844; }","duration":"334.292702ms","start":"2026-01-29T19:07:24.702223Z","end":"2026-01-29T19:07:25.036515Z","steps":["trace[265390727] 'agreement among raft nodes before linearized reading'  (duration: 334.136409ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:25.036553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:24.702209Z","time spent":"334.336143ms","remote":"127.0.0.1:36344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":15,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T19:07:26.412001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.23691ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126946916 > lease_revoke:<id:6c6c9c0b25b5298b>","response":"size:28"}
{"level":"info","ts":"2026-01-29T19:07:26.412083Z","caller":"traceutil/trace.go:171","msg":"trace[1154441383] linearizableReadLoop","detail":"{readStateIndex:880; appliedIndex:879; }","duration":"536.536372ms","start":"2026-01-29T19:07:25.875532Z","end":"2026-01-29T19:07:26.412068Z","steps":["trace[1154441383] 'read index received'  (duration: 93.180519ms)","trace[1154441383] 'applied index is now lower than readState.Index'  (duration: 443.354573ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:07:26.412401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.861078ms","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-29T19:07:26.412419Z","caller":"traceutil/trace.go:171","msg":"trace[1508111307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:845; }","duration":"536.905949ms","start":"2026-01-29T19:07:25.875505Z","end":"2026-01-29T19:07:26.412411Z","steps":["trace[1508111307] 'agreement among raft nodes before linearized reading'  (duration: 536.817507ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:26.412437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:25.875492Z","time spent":"536.939439ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-29T19:07:26.412517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.907275ms","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-29T19:07:26.412568Z","caller":"traceutil/trace.go:171","msg":"trace[1093764845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:845; }","duration":"330.993497ms","start":"2026-01-29T19:07:26.081561Z","end":"2026-01-29T19:07:26.412554Z","steps":["trace[1093764845] 'agreement among raft nodes before linearized reading'  (duration: 330.826593ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:26.412594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:26.081547Z","time spent":"331.041757ms","remote":"127.0.0.1:36486","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-29T19:07:26.412639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.564422ms","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-29T19:07:26.41267Z","caller":"traceutil/trace.go:171","msg":"trace[1970388908] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:845; }","duration":"321.595532ms","start":"2026-01-29T19:07:26.091055Z","end":"2026-01-29T19:07:26.412651Z","steps":["trace[1970388908] 'agreement among raft nodes before linearized reading'  (duration: 321.549382ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:26.412684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:26.091044Z","time spent":"321.636813ms","remote":"127.0.0.1:36486","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-29T19:07:26.795652Z","caller":"traceutil/trace.go:171","msg":"trace[142040538] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"378.469738ms","start":"2026-01-29T19:07:26.416986Z","end":"2026-01-29T19:07:26.795456Z","steps":["trace[142040538] 'process raft request'  (duration: 378.366156ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:26.795748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:26.416971Z","time spent":"378.727435ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:841 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-01-29T19:07:27.341416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.826674ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126946920 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:840 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T19:07:27.341538Z","caller":"traceutil/trace.go:171","msg":"trace[151593686] linearizableReadLoop","detail":"{readStateIndex:883; appliedIndex:881; }","duration":"359.424975ms","start":"2026-01-29T19:07:26.982102Z","end":"2026-01-29T19:07:27.341527Z","steps":["trace[151593686] 'read index received'  (duration: 137.443448ms)","trace[151593686] 'applied index is now lower than readState.Index'  (duration: 221.980837ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:07:27.341588Z","caller":"traceutil/trace.go:171","msg":"trace[2062232794] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"924.121648ms","start":"2026-01-29T19:07:26.417462Z","end":"2026-01-29T19:07:27.341583Z","steps":["trace[2062232794] 'process raft request'  (duration: 924.009886ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:27.341618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:26.417458Z","time spent":"924.143458ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:842 > 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-29T19:07:27.341605Z","caller":"traceutil/trace.go:171","msg":"trace[1054140306] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"924.180599ms","start":"2026-01-29T19:07:26.417404Z","end":"2026-01-29T19:07:27.341584Z","steps":["trace[1054140306] 'process raft request'  (duration: 702.132851ms)","trace[1054140306] 'compare'  (duration: 221.66354ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:07:27.341697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:26.41739Z","time spent":"924.253491ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:840 > 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-29T19:07:27.341734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.632289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:07:27.341749Z","caller":"traceutil/trace.go:171","msg":"trace[636108554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:848; }","duration":"359.671599ms","start":"2026-01-29T19:07:26.982072Z","end":"2026-01-29T19:07:27.341744Z","steps":["trace[636108554] 'agreement among raft nodes before linearized reading'  (duration: 359.646068ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:27.341764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:26.982054Z","time spent":"359.70551ms","remote":"127.0.0.1:34854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-29T19:07:27.341887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.856431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-29T19:07:27.341903Z","caller":"traceutil/trace.go:171","msg":"trace[1511171681] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:848; }","duration":"341.897432ms","start":"2026-01-29T19:07:27Z","end":"2026-01-29T19:07:27.341897Z","steps":["trace[1511171681] 'agreement among raft nodes before linearized reading'  (duration: 341.84328ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:27.341915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:26.999984Z","time spent":"341.927472ms","remote":"127.0.0.1:34912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":85,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T19:07:27.341994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.247732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:07:27.342013Z","caller":"traceutil/trace.go:171","msg":"trace[160266321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:848; }","duration":"304.288243ms","start":"2026-01-29T19:07:27.037719Z","end":"2026-01-29T19:07:27.342007Z","steps":["trace[160266321] 'agreement among raft nodes before linearized reading'  (duration: 304.256602ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:27.342023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.3631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-01-29T19:07:27.342028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:27.037703Z","time spent":"304.321663ms","remote":"127.0.0.1:34858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-29T19:07:27.342037Z","caller":"traceutil/trace.go:171","msg":"trace[1171698474] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:848; }","duration":"288.39866ms","start":"2026-01-29T19:07:27.053634Z","end":"2026-01-29T19:07:27.342033Z","steps":["trace[1171698474] 'agreement among raft nodes before linearized reading'  (duration: 288.333999ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:27.342138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.770243ms","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-29T19:07:27.342152Z","caller":"traceutil/trace.go:171","msg":"trace[1191781903] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:848; }","duration":"301.794834ms","start":"2026-01-29T19:07:27.040352Z","end":"2026-01-29T19:07:27.342147Z","steps":["trace[1191781903] 'agreement among raft nodes before linearized reading'  (duration: 301.733762ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:27.342167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:27.040345Z","time spent":"301.819154ms","remote":"127.0.0.1:36486","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-29T19:07:27.471853Z","caller":"traceutil/trace.go:171","msg":"trace[1880294682] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"123.565255ms","start":"2026-01-29T19:07:27.34827Z","end":"2026-01-29T19:07:27.471835Z","steps":["trace[1880294682] 'process raft request'  (duration: 114.196481ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:07:31.009189Z","caller":"traceutil/trace.go:171","msg":"trace[1906120525] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"508.704005ms","start":"2026-01-29T19:07:30.500472Z","end":"2026-01-29T19:07:31.009176Z","steps":["trace[1906120525] 'process raft request'  (duration: 508.44721ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:31.009306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:30.500447Z","time spent":"508.790317ms","remote":"127.0.0.1:34876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.131\" mod_revision:781 > success:<request_put:<key:\"/registry/masterleases/199.204.45.131\" value_size:67 lease:7812791025272171134 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.131\" > >"}
{"level":"info","ts":"2026-01-29T19:07:31.009136Z","caller":"traceutil/trace.go:171","msg":"trace[1791904889] linearizableReadLoop","detail":"{readStateIndex:892; appliedIndex:891; }","duration":"199.409415ms","start":"2026-01-29T19:07:30.809708Z","end":"2026-01-29T19:07:31.009118Z","steps":["trace[1791904889] 'read index received'  (duration: 199.372314ms)","trace[1791904889] 'applied index is now lower than readState.Index'  (duration: 36.341µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:07:31.009822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.108658ms","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-29T19:07:31.009851Z","caller":"traceutil/trace.go:171","msg":"trace[1497707377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:856; }","duration":"200.17585ms","start":"2026-01-29T19:07:30.809666Z","end":"2026-01-29T19:07:31.009842Z","steps":["trace[1497707377] 'agreement among raft nodes before linearized reading'  (duration: 199.986806ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:07:40.681343Z","caller":"traceutil/trace.go:171","msg":"trace[1997492266] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"217.360545ms","start":"2026-01-29T19:07:40.463949Z","end":"2026-01-29T19:07:40.681309Z","steps":["trace[1997492266] 'process raft request'  (duration: 217.132651ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:07:41.321Z","caller":"traceutil/trace.go:171","msg":"trace[1012293677] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"186.328438ms","start":"2026-01-29T19:07:41.134657Z","end":"2026-01-29T19:07:41.320985Z","steps":["trace[1012293677] 'process raft request'  (duration: 186.240446ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:42.075424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.442023ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126947036 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:882 > 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-29T19:07:42.075498Z","caller":"traceutil/trace.go:171","msg":"trace[693323359] linearizableReadLoop","detail":"{readStateIndex:927; appliedIndex:926; }","duration":"512.293656ms","start":"2026-01-29T19:07:41.563194Z","end":"2026-01-29T19:07:42.075488Z","steps":["trace[693323359] 'read index received'  (duration: 39.691089ms)","trace[693323359] 'applied index is now lower than readState.Index'  (duration: 472.601547ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:07:42.075636Z","caller":"traceutil/trace.go:171","msg":"trace[1914527883] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"527.527704ms","start":"2026-01-29T19:07:41.5481Z","end":"2026-01-29T19:07:42.075628Z","steps":["trace[1914527883] 'process raft request'  (duration: 54.830126ms)","trace[1914527883] 'compare'  (duration: 472.060306ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:07:42.075675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:41.548088Z","time spent":"527.566015ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:882 > 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-29T19:07:42.07582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.625412ms","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-29T19:07:42.075838Z","caller":"traceutil/trace.go:171","msg":"trace[787846913] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:889; }","duration":"512.666813ms","start":"2026-01-29T19:07:41.563166Z","end":"2026-01-29T19:07:42.075832Z","steps":["trace[787846913] 'agreement among raft nodes before linearized reading'  (duration: 512.600312ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:42.075857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:41.563151Z","time spent":"512.701854ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-29T19:07:42.447273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.938489ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126947040 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:883 > 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-29T19:07:42.447352Z","caller":"traceutil/trace.go:171","msg":"trace[1884329728] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"365.899462ms","start":"2026-01-29T19:07:42.081441Z","end":"2026-01-29T19:07:42.44734Z","steps":["trace[1884329728] 'process raft request'  (duration: 257.841481ms)","trace[1884329728] 'compare'  (duration: 107.857288ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:07:42.447384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:42.081416Z","time spent":"365.954163ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:883 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-29T19:07:44.664054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.9713ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126947058 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-rktqs.188f49338cb2045d\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-rktqs.188f49338cb2045d\" value_size:706 lease:7812791025272171036 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-01-29T19:07:44.665388Z","caller":"traceutil/trace.go:171","msg":"trace[363685892] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:935; }","duration":"248.381534ms","start":"2026-01-29T19:07:44.416983Z","end":"2026-01-29T19:07:44.665364Z","steps":["trace[363685892] 'read index received'  (duration: 23.19µs)","trace[363685892] 'applied index is now lower than readState.Index'  (duration: 248.357274ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:07:44.665461Z","caller":"traceutil/trace.go:171","msg":"trace[1510723667] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"314.108056ms","start":"2026-01-29T19:07:44.351345Z","end":"2026-01-29T19:07:44.665453Z","steps":["trace[1510723667] 'process raft request'  (duration: 44.665227ms)","trace[1510723667] 'compare'  (duration: 267.886199ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:07:44.665507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:44.351333Z","time spent":"314.150727ms","remote":"127.0.0.1:34912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":799,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-rktqs.188f49338cb2045d\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-rktqs.188f49338cb2045d\" value_size:706 lease:7812791025272171036 >> failure:<>"}
{"level":"warn","ts":"2026-01-29T19:07:44.666364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.371884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:07:44.666397Z","caller":"traceutil/trace.go:171","msg":"trace[1906710529] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:898; }","duration":"249.431706ms","start":"2026-01-29T19:07:44.416957Z","end":"2026-01-29T19:07:44.666389Z","steps":["trace[1906710529] 'agreement among raft nodes before linearized reading'  (duration: 249.363404ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:44.66677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.422369ms","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-29T19:07:44.666803Z","caller":"traceutil/trace.go:171","msg":"trace[2059560535] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:898; }","duration":"214.455319ms","start":"2026-01-29T19:07:44.452339Z","end":"2026-01-29T19:07:44.666794Z","steps":["trace[2059560535] 'agreement among raft nodes before linearized reading'  (duration: 214.359798ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:07:47.731554Z","caller":"traceutil/trace.go:171","msg":"trace[286308305] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"169.110579ms","start":"2026-01-29T19:07:47.562423Z","end":"2026-01-29T19:07:47.731534Z","steps":["trace[286308305] 'process raft request'  (duration: 98.869161ms)","trace[286308305] 'compare'  (duration: 70.144946ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:07:59.383495Z","caller":"traceutil/trace.go:171","msg":"trace[1933839881] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1017; }","duration":"497.299111ms","start":"2026-01-29T19:07:58.886177Z","end":"2026-01-29T19:07:59.383476Z","steps":["trace[1933839881] 'read index received'  (duration: 497.085377ms)","trace[1933839881] 'applied index is now lower than readState.Index'  (duration: 213.114µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:07:59.383569Z","caller":"traceutil/trace.go:171","msg":"trace[1648472016] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"583.635966ms","start":"2026-01-29T19:07:58.799929Z","end":"2026-01-29T19:07:59.383565Z","steps":["trace[1648472016] 'process raft request'  (duration: 583.412741ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:59.383661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:58.799912Z","time spent":"583.675716ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:967 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-29T19:07:59.383923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.74504ms","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-29T19:07:59.383945Z","caller":"traceutil/trace.go:171","msg":"trace[675990683] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:977; }","duration":"497.797971ms","start":"2026-01-29T19:07:58.886141Z","end":"2026-01-29T19:07:59.383939Z","steps":["trace[675990683] 'agreement among raft nodes before linearized reading'  (duration: 497.720739ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:59.383959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:07:58.886126Z","time spent":"497.830072ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-01-29T19:07:59.384058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.43799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-01-29T19:07:59.38408Z","caller":"traceutil/trace.go:171","msg":"trace[1216054647] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:977; }","duration":"291.484041ms","start":"2026-01-29T19:07:59.092588Z","end":"2026-01-29T19:07:59.384072Z","steps":["trace[1216054647] 'agreement among raft nodes before linearized reading'  (duration: 291.43821ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:07:59.390621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.253806ms","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-29T19:07:59.391097Z","caller":"traceutil/trace.go:171","msg":"trace[1830790105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:977; }","duration":"161.769996ms","start":"2026-01-29T19:07:59.229309Z","end":"2026-01-29T19:07:59.391079Z","steps":["trace[1830790105] 'agreement among raft nodes before linearized reading'  (duration: 155.152216ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:08:09.963856Z","caller":"traceutil/trace.go:171","msg":"trace[2019902207] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"105.391565ms","start":"2026-01-29T19:08:09.858444Z","end":"2026-01-29T19:08:09.963836Z","steps":["trace[2019902207] 'process raft request'  (duration: 105.261452ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:08:12.088918Z","caller":"traceutil/trace.go:171","msg":"trace[1631502788] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"116.176778ms","start":"2026-01-29T19:08:11.972722Z","end":"2026-01-29T19:08:12.088899Z","steps":["trace[1631502788] 'process raft request'  (duration: 84.695398ms)","trace[1631502788] 'compare'  (duration: 30.822667ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:09:07.163614Z","caller":"traceutil/trace.go:171","msg":"trace[1670591813] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"101.119963ms","start":"2026-01-29T19:09:07.062472Z","end":"2026-01-29T19:09:07.163592Z","steps":["trace[1670591813] 'process raft request'  (duration: 31.857297ms)","trace[1670591813] 'compare'  (duration: 69.181455ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:09:39.252121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.04904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:09:39.252181Z","caller":"traceutil/trace.go:171","msg":"trace[1869904904] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1402; }","duration":"216.141022ms","start":"2026-01-29T19:09:39.036026Z","end":"2026-01-29T19:09:39.252167Z","steps":["trace[1869904904] 'range keys from in-memory index tree'  (duration: 215.988819ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:09:39.252531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.753984ms","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-29T19:09:39.252551Z","caller":"traceutil/trace.go:171","msg":"trace[1767899955] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1402; }","duration":"431.807286ms","start":"2026-01-29T19:09:38.820737Z","end":"2026-01-29T19:09:39.252545Z","steps":["trace[1767899955] 'range keys from in-memory index tree'  (duration: 431.522289ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:09:39.25257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:09:38.820719Z","time spent":"431.845246ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-29T19:09:39.252825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.14747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-01-29T19:09:39.252844Z","caller":"traceutil/trace.go:171","msg":"trace[106760995] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1402; }","duration":"118.16731ms","start":"2026-01-29T19:09:39.134671Z","end":"2026-01-29T19:09:39.252838Z","steps":["trace[106760995] 'range keys from in-memory index tree'  (duration: 118.080659ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:09:40.691443Z","caller":"traceutil/trace.go:171","msg":"trace[403248020] linearizableReadLoop","detail":"{readStateIndex:1468; appliedIndex:1467; }","duration":"408.003044ms","start":"2026-01-29T19:09:40.283425Z","end":"2026-01-29T19:09:40.691428Z","steps":["trace[403248020] 'read index received'  (duration: 407.850601ms)","trace[403248020] 'applied index is now lower than readState.Index'  (duration: 151.903µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:09:40.691514Z","caller":"traceutil/trace.go:171","msg":"trace[2113432919] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"541.055988ms","start":"2026-01-29T19:09:40.150449Z","end":"2026-01-29T19:09:40.691505Z","steps":["trace[2113432919] 'process raft request'  (duration: 540.890725ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:09:40.691589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:09:40.150436Z","time spent":"541.095739ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1399 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-29T19:09:40.691652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.081789ms","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-29T19:09:40.691698Z","caller":"traceutil/trace.go:171","msg":"trace[415068105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1407; }","duration":"398.145181ms","start":"2026-01-29T19:09:40.293542Z","end":"2026-01-29T19:09:40.691687Z","steps":["trace[415068105] 'agreement among raft nodes before linearized reading'  (duration: 398.042049ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:09:40.691717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:09:40.293534Z","time spent":"398.179321ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-29T19:09:40.69185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.335647ms","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-29T19:09:40.691865Z","caller":"traceutil/trace.go:171","msg":"trace[1718463653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1407; }","duration":"102.349657ms","start":"2026-01-29T19:09:40.58951Z","end":"2026-01-29T19:09:40.69186Z","steps":["trace[1718463653] 'agreement among raft nodes before linearized reading'  (duration: 102.307646ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:09:40.691921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.497054ms","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-29T19:09:40.691941Z","caller":"traceutil/trace.go:171","msg":"trace[726845896] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1407; }","duration":"408.516505ms","start":"2026-01-29T19:09:40.283419Z","end":"2026-01-29T19:09:40.691935Z","steps":["trace[726845896] 'agreement among raft nodes before linearized reading'  (duration: 408.472454ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:09:40.691948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.952096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.131\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-01-29T19:09:40.691964Z","caller":"traceutil/trace.go:171","msg":"trace[620657913] range","detail":"{range_begin:/registry/masterleases/199.204.45.131; range_end:; response_count:1; response_revision:1407; }","duration":"258.999206ms","start":"2026-01-29T19:09:40.432961Z","end":"2026-01-29T19:09:40.69196Z","steps":["trace[620657913] 'agreement among raft nodes before linearized reading'  (duration: 258.960675ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:09:40.691957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:09:40.283369Z","time spent":"408.585166ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-01-29T19:09:59.786507Z","caller":"traceutil/trace.go:171","msg":"trace[1792503699] transaction","detail":"{read_only:false; response_revision:1486; number_of_response:1; }","duration":"202.121655ms","start":"2026-01-29T19:09:59.584363Z","end":"2026-01-29T19:09:59.786485Z","steps":["trace[1792503699] 'process raft request'  (duration: 201.993473ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:09:59.971555Z","caller":"traceutil/trace.go:171","msg":"trace[28292845] linearizableReadLoop","detail":"{readStateIndex:1552; appliedIndex:1551; }","duration":"121.468436ms","start":"2026-01-29T19:09:59.850073Z","end":"2026-01-29T19:09:59.971541Z","steps":["trace[28292845] 'read index received'  (duration: 93.758369ms)","trace[28292845] 'applied index is now lower than readState.Index'  (duration: 27.709507ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:09:59.97168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.596278ms","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-29T19:09:59.971704Z","caller":"traceutil/trace.go:171","msg":"trace[1795724173] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1487; }","duration":"121.69937ms","start":"2026-01-29T19:09:59.849996Z","end":"2026-01-29T19:09:59.971696Z","steps":["trace[1795724173] 'agreement among raft nodes before linearized reading'  (duration: 121.596448ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:09:59.971874Z","caller":"traceutil/trace.go:171","msg":"trace[1754873661] transaction","detail":"{read_only:false; response_revision:1487; number_of_response:1; }","duration":"158.305522ms","start":"2026-01-29T19:09:59.813559Z","end":"2026-01-29T19:09:59.971865Z","steps":["trace[1754873661] 'process raft request'  (duration: 130.32162ms)","trace[1754873661] 'compare'  (duration: 27.448121ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:10:05.125097Z","caller":"traceutil/trace.go:171","msg":"trace[287581902] linearizableReadLoop","detail":"{readStateIndex:1574; appliedIndex:1572; }","duration":"147.135161ms","start":"2026-01-29T19:10:04.977942Z","end":"2026-01-29T19:10:05.125077Z","steps":["trace[287581902] 'read index received'  (duration: 61.014982ms)","trace[287581902] 'applied index is now lower than readState.Index'  (duration: 86.119019ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:10:05.125164Z","caller":"traceutil/trace.go:171","msg":"trace[1240476536] transaction","detail":"{read_only:false; response_revision:1507; number_of_response:1; }","duration":"266.867571ms","start":"2026-01-29T19:10:04.858269Z","end":"2026-01-29T19:10:05.125136Z","steps":["trace[1240476536] 'process raft request'  (duration: 180.766683ms)","trace[1240476536] 'compare'  (duration: 85.820063ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:10:05.125203Z","caller":"traceutil/trace.go:171","msg":"trace[60061751] transaction","detail":"{read_only:false; response_revision:1508; number_of_response:1; }","duration":"262.099797ms","start":"2026-01-29T19:10:04.863092Z","end":"2026-01-29T19:10:05.125192Z","steps":["trace[60061751] 'process raft request'  (duration: 261.903383ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:05.125386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.434317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-01-29T19:10:05.125412Z","caller":"traceutil/trace.go:171","msg":"trace[2044390556] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1508; }","duration":"147.530648ms","start":"2026-01-29T19:10:04.977871Z","end":"2026-01-29T19:10:05.125402Z","steps":["trace[2044390556] 'agreement among raft nodes before linearized reading'  (duration: 147.430056ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:05.125496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.840877ms","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-29T19:10:05.12552Z","caller":"traceutil/trace.go:171","msg":"trace[944298757] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1508; }","duration":"141.898547ms","start":"2026-01-29T19:10:04.983613Z","end":"2026-01-29T19:10:05.125512Z","steps":["trace[944298757] 'agreement among raft nodes before linearized reading'  (duration: 141.805876ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:05.958447Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948571,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:09.041496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000849911s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-01-29T19:10:10.309468Z","caller":"traceutil/trace.go:171","msg":"trace[707409164] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"3.268872715s","start":"2026-01-29T19:10:07.040578Z","end":"2026-01-29T19:10:10.309451Z","steps":["trace[707409164] 'agreement among raft nodes before linearized reading'  (duration: 2.000876472s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:10.31554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:07.040561Z","time spent":"3.274949624s","remote":"127.0.0.1:34854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/01/29 19:10:10 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-01-29T19:10:10.458147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000195953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-01-29T19:10:10.458226Z","caller":"traceutil/trace.go:171","msg":"trace[721084021] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"5.000323976s","start":"2026-01-29T19:10:05.457883Z","end":"2026-01-29T19:10:10.458207Z","steps":["trace[721084021] 'agreement among raft nodes before linearized reading'  (duration: 5.000228854s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:10.458268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:05.45786Z","time spent":"5.000399427s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-29T19:10:10.787438Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948571,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:11.2885Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948571,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:11.788844Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948571,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:11.843407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999319525s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-01-29T19:10:11.843487Z","caller":"traceutil/trace.go:171","msg":"trace[786574508] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999491248s","start":"2026-01-29T19:10:06.843978Z","end":"2026-01-29T19:10:11.843469Z","steps":["trace[786574508] 'agreement among raft nodes before linearized reading'  (duration: 4.999326345s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:11.843546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:06.843959Z","time spent":"4.99957793s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-29T19:10:12.130191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.99956972s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-01-29T19:10:12.130245Z","caller":"traceutil/trace.go:171","msg":"trace[1259843077] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999677583s","start":"2026-01-29T19:10:07.130555Z","end":"2026-01-29T19:10:12.130232Z","steps":["trace[1259843077] 'agreement among raft nodes before linearized reading'  (duration: 4.999602961s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:12.130274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:07.130532Z","time spent":"4.999737614s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-29T19:10:12.133593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:05.133505Z","time spent":"7.000086326s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-01-29T19:10:12.28928Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948571,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:12.300543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000398773s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-01-29T19:10:12.300619Z","caller":"traceutil/trace.go:171","msg":"trace[1500841582] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000510165s","start":"2026-01-29T19:10:10.300091Z","end":"2026-01-29T19:10:12.300601Z","steps":["trace[1500841582] 'agreement among raft nodes before linearized reading'  (duration: 2.000408643s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:12.300676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:10.300087Z","time spent":"2.000580506s","remote":"127.0.0.1:34854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-29T19:10:12.305378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000309001s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-01-29T19:10:12.305419Z","caller":"traceutil/trace.go:171","msg":"trace[1089030786] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000369783s","start":"2026-01-29T19:10:10.305039Z","end":"2026-01-29T19:10:12.305409Z","steps":["trace[1089030786] 'agreement among raft nodes before linearized reading'  (duration: 2.000316442s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:12.305443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:10.305034Z","time spent":"2.000405094s","remote":"127.0.0.1:34858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-29T19:10:12.45831Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"}
{"level":"warn","ts":"2026-01-29T19:10:12.602209Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"6c6c9c0b25b53037","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-01-29T19:10:12.958997Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:13.459988Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:13.961031Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:14.312423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000780861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-01-29T19:10:14.312494Z","caller":"traceutil/trace.go:171","msg":"trace[1628480465] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000878403s","start":"2026-01-29T19:10:12.311601Z","end":"2026-01-29T19:10:14.31248Z","steps":["trace[1628480465] 'agreement among raft nodes before linearized reading'  (duration: 2.000775401s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:14.312525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:12.311573Z","time spent":"2.000946914s","remote":"127.0.0.1:34854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-29T19:10:14.462747Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:14.622815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:07.621942Z","time spent":"7.000866321s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-01-29T19:10:14.963213Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:15.457687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.94909402s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-01-29T19:10:15.457815Z","caller":"traceutil/trace.go:171","msg":"trace[821196320] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.949287864s","start":"2026-01-29T19:10:12.508495Z","end":"2026-01-29T19:10:15.457782Z","steps":["trace[821196320] 'agreement among raft nodes before linearized reading'  (duration: 2.949117141s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:15.457905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:12.508478Z","time spent":"2.949410556s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
2026/01/29 19:10:15 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-01-29T19:10:15.464148Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:15.778904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.005026198s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-01-29T19:10:15.778962Z","caller":"traceutil/trace.go:171","msg":"trace[127070062] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; }","duration":"10.005130079s","start":"2026-01-29T19:10:05.773817Z","end":"2026-01-29T19:10:15.778947Z","steps":["trace[127070062] 'agreement among raft nodes before linearized reading'  (duration: 10.005054928s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:15.778996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:05.7738Z","time spent":"10.00518838s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
2026/01/29 19:10:15 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-01-29T19:10:15.827109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.022446271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-01-29T19:10:15.827231Z","caller":"traceutil/trace.go:171","msg":"trace[873681310] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; }","duration":"10.022626386s","start":"2026-01-29T19:10:05.804582Z","end":"2026-01-29T19:10:15.827208Z","steps":["trace[873681310] 'agreement among raft nodes before linearized reading'  (duration: 10.022479902s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:15.827353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:05.804561Z","time spent":"10.022737978s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
2026/01/29 19:10:15 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-01-29T19:10:15.965221Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:16.314203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.001135278s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-01-29T19:10:16.314278Z","caller":"traceutil/trace.go:171","msg":"trace[2005319239] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00125263s","start":"2026-01-29T19:10:14.313008Z","end":"2026-01-29T19:10:16.31426Z","steps":["trace[2005319239] 'agreement among raft nodes before linearized reading'  (duration: 2.001156209s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:16.314341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:14.312997Z","time spent":"2.001334892s","remote":"127.0.0.1:34858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-29T19:10:16.465601Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:16.843819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.999130927s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-01-29T19:10:16.843899Z","caller":"traceutil/trace.go:171","msg":"trace[196402526] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.999251018s","start":"2026-01-29T19:10:13.844627Z","end":"2026-01-29T19:10:16.843878Z","steps":["trace[196402526] 'agreement among raft nodes before linearized reading'  (duration: 2.999151987s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:16.843944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:13.844614Z","time spent":"2.99932133s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/01/29 19:10:16 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-01-29T19:10:16.898479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999435568s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-01-29T19:10:16.898528Z","caller":"traceutil/trace.go:171","msg":"trace[1568988781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"9.999618911s","start":"2026-01-29T19:10:06.898896Z","end":"2026-01-29T19:10:16.898515Z","steps":["trace[1568988781] 'agreement among raft nodes before linearized reading'  (duration: 9.9995418s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:16.898566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:06.898868Z","time spent":"9.999691293s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
2026/01/29 19:10:16 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-01-29T19:10:16.966472Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:17.130402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.891984444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-01-29T19:10:17.130455Z","caller":"traceutil/trace.go:171","msg":"trace[1629964538] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.892069277s","start":"2026-01-29T19:10:14.238373Z","end":"2026-01-29T19:10:17.130442Z","steps":["trace[1629964538] 'agreement among raft nodes before linearized reading'  (duration: 2.892001255s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:17.130487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:14.238358Z","time spent":"2.892120237s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/01/29 19:10:17 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-01-29T19:10:17.131226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999577341s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-01-29T19:10:17.131248Z","caller":"traceutil/trace.go:171","msg":"trace[1765943990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"9.999627442s","start":"2026-01-29T19:10:07.131615Z","end":"2026-01-29T19:10:17.131243Z","steps":["trace[1765943990] 'agreement among raft nodes before linearized reading'  (duration: 9.999602392s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:17.131266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:07.131607Z","time spent":"9.999656263s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
2026/01/29 19:10:17 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-01-29T19:10:17.252172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.000113721s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-01-29T19:10:17.252342Z","caller":"traceutil/trace.go:171","msg":"trace[1629324121] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; }","duration":"10.000322075s","start":"2026-01-29T19:10:07.252004Z","end":"2026-01-29T19:10:17.252326Z","steps":["trace[1629324121] 'agreement among raft nodes before linearized reading'  (duration: 10.000133542s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:17.252445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:07.251993Z","time spent":"10.000441697s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}
2026/01/29 19:10:17 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-01-29T19:10:17.466833Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:17.967805Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:18.321645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000346653s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-01-29T19:10:18.321865Z","caller":"traceutil/trace.go:171","msg":"trace[975124406] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000603418s","start":"2026-01-29T19:10:16.321243Z","end":"2026-01-29T19:10:18.321846Z","steps":["trace[975124406] 'agreement among raft nodes before linearized reading'  (duration: 2.000368443s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:18.321933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:16.321228Z","time spent":"2.00069673s","remote":"127.0.0.1:34854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/01/29 19:10:18 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-01-29T19:10:18.468626Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:18.969427Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948578,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:19.303295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:12.30315Z","time spent":"7.000139418s","remote":"127.0.0.1:34912","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-01-29T19:10:19.459187Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"}
{"level":"warn","ts":"2026-01-29T19:10:19.459576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.239777094s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-01-29T19:10:19.459631Z","caller":"traceutil/trace.go:171","msg":"trace[1540557196] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; }","duration":"7.239919376s","start":"2026-01-29T19:10:12.219694Z","end":"2026-01-29T19:10:19.459613Z","steps":["trace[1540557196] 'agreement among raft nodes before linearized reading'  (duration: 7.239658581s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:19.459789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:12.219675Z","time spent":"7.24009982s","remote":"127.0.0.1:36554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":0,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T19:10:19.45971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.165612647s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-01-29T19:10:19.459974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.076576415s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-01-29T19:10:19.460139Z","caller":"traceutil/trace.go:171","msg":"trace[1345045349] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; }","duration":"12.076720828s","start":"2026-01-29T19:10:07.383361Z","end":"2026-01-29T19:10:19.460082Z","steps":["trace[1345045349] 'agreement among raft nodes before linearized reading'  (duration: 12.076600066s)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:10:19.460201Z","caller":"traceutil/trace.go:171","msg":"trace[1888000174] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; }","duration":"9.166209638s","start":"2026-01-29T19:10:10.293933Z","end":"2026-01-29T19:10:19.460143Z","steps":["trace[1888000174] 'agreement among raft nodes before linearized reading'  (duration: 9.165644727s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:19.460304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:10.293912Z","time spent":"9.166347721s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-01-29T19:10:19.46044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.447801855s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-01-29T19:10:19.460536Z","caller":"traceutil/trace.go:171","msg":"trace[81958370] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; }","duration":"7.447928029s","start":"2026-01-29T19:10:12.012597Z","end":"2026-01-29T19:10:19.460525Z","steps":["trace[81958370] 'agreement among raft nodes before linearized reading'  (duration: 7.447827726s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:19.460622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:12.012582Z","time spent":"7.44802611s","remote":"127.0.0.1:36718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":0,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T19:10:19.460181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:07.383308Z","time spent":"12.076863131s","remote":"127.0.0.1:36430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":0,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T19:10:19.460742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.025985624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.131\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-01-29T19:10:19.460939Z","caller":"traceutil/trace.go:171","msg":"trace[2104299971] range","detail":"{range_begin:/registry/masterleases/199.204.45.131; range_end:; }","duration":"9.026194498s","start":"2026-01-29T19:10:10.434711Z","end":"2026-01-29T19:10:19.460905Z","steps":["trace[2104299971] 'agreement among raft nodes before linearized reading'  (duration: 9.026021645s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:19.461011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:10.434691Z","time spent":"9.02630848s","remote":"127.0.0.1:34876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":0,"request content":"key:\"/registry/masterleases/199.204.45.131\" "}
{"level":"warn","ts":"2026-01-29T19:10:19.460963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.043519991s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-01-29T19:10:19.461604Z","caller":"traceutil/trace.go:171","msg":"trace[2135980492] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; }","duration":"13.044371228s","start":"2026-01-29T19:10:06.41722Z","end":"2026-01-29T19:10:19.461592Z","steps":["trace[2135980492] 'agreement among raft nodes before linearized reading'  (duration: 13.043551872s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:19.461782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:06.417203Z","time spent":"13.044561901s","remote":"127.0.0.1:35166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T19:10:19.776315Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"6c6c9c0b25b53037","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-01-29T19:10:19.959507Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948589,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:20.321871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000009567s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-01-29T19:10:20.321991Z","caller":"traceutil/trace.go:171","msg":"trace[721441678] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00021518s","start":"2026-01-29T19:10:18.321753Z","end":"2026-01-29T19:10:20.321969Z","steps":["trace[721441678] 'agreement among raft nodes before linearized reading'  (duration: 2.000039217s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:20.322072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:18.321738Z","time spent":"2.000323252s","remote":"127.0.0.1:34858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-29T19:10:20.459844Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948589,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:20.960716Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17036163062126948589,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:10:21.010312Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"15.832950554s","expected-duration":"1s"}
{"level":"warn","ts":"2026-01-29T19:10:21.115305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:14.114308Z","time spent":"7.000990106s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-01-29T19:10:21.487836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.326844ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126948573 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1487 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<>>","response":"size:16"}
{"level":"warn","ts":"2026-01-29T19:10:21.463244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.580604ms","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-29T19:10:21.488308Z","caller":"traceutil/trace.go:171","msg":"trace[281439570] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1509; }","duration":"583.655718ms","start":"2026-01-29T19:10:20.904633Z","end":"2026-01-29T19:10:21.488289Z","steps":["trace[281439570] 'range keys from in-memory index tree'  (duration: 558.565763ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.453858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"15.593099944s","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-29T19:10:21.489253Z","caller":"traceutil/trace.go:171","msg":"trace[1368805304] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1509; }","duration":"15.628501493s","start":"2026-01-29T19:10:05.860736Z","end":"2026-01-29T19:10:21.489237Z","steps":["trace[1368805304] 'range keys from in-memory index tree'  (duration: 15.593086954s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.599809Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"93.512273ms","request":"header:<ID:17036163062126948579 > lease_revoke:<id:6c6c9c0b25b53037>","response":"size:28","error":"lease not found"}
{"level":"warn","ts":"2026-01-29T19:10:21.626025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:14.625953Z","time spent":"7.000067849s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"info","ts":"2026-01-29T19:10:21.653183Z","caller":"traceutil/trace.go:171","msg":"trace[199440930] transaction","detail":"{read_only:false; response_revision:1514; number_of_response:1; }","duration":"4.806421274s","start":"2026-01-29T19:10:16.846744Z","end":"2026-01-29T19:10:21.653165Z","steps":["trace[199440930] 'process raft request'  (duration: 4.806158479s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.65336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:16.846704Z","time spent":"4.806529937s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1505 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:392 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-01-29T19:10:21.6537Z","caller":"traceutil/trace.go:171","msg":"trace[1784310176] transaction","detail":"{read_only:false; response_revision:1515; number_of_response:1; }","duration":"4.694199541s","start":"2026-01-29T19:10:16.959489Z","end":"2026-01-29T19:10:21.653689Z","steps":["trace[1784310176] 'process raft request'  (duration: 4.69363875s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.653767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:16.959472Z","time spent":"4.694263262s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":415,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1506 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:363 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-01-29T19:10:21.654099Z","caller":"traceutil/trace.go:171","msg":"trace[1027744438] transaction","detail":"{read_only:false; response_revision:1516; number_of_response:1; }","duration":"4.518765093s","start":"2026-01-29T19:10:17.135323Z","end":"2026-01-29T19:10:21.654088Z","steps":["trace[1027744438] 'process raft request'  (duration: 4.518326584s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.654184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:17.135294Z","time spent":"4.518860796s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1508 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:366 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-01-29T19:10:21.654498Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"9.58µs","request":"header:<ID:17036163062126948590 > lease_revoke:<id:6c6c9c0b25b53037>","response":"size:28","error":"lease not found"}
{"level":"info","ts":"2026-01-29T19:10:21.654563Z","caller":"traceutil/trace.go:171","msg":"trace[1935608870] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1517; }","duration":"478.031726ms","start":"2026-01-29T19:10:21.176525Z","end":"2026-01-29T19:10:21.654556Z","steps":["trace[1935608870] 'process raft request'  (duration: 478.007036ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.654599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:21.176501Z","time spent":"478.080028ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":720,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1504 > 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-29T19:10:21.654716Z","caller":"traceutil/trace.go:171","msg":"trace[230491682] transaction","detail":"{read_only:false; response_revision:1517; number_of_response:1; }","duration":"4.518717301s","start":"2026-01-29T19:10:17.135993Z","end":"2026-01-29T19:10:21.654711Z","steps":["trace[230491682] 'process raft request'  (duration: 4.518058149s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.654752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:17.135987Z","time spent":"4.518748152s","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":409,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1507 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:359 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-01-29T19:10:21.654808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:19.312249Z","time spent":"2.342558131s","remote":"127.0.0.1:34912","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-01-29T19:10:21.654883Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"6c6c9c0b25b53037","error":"lease not found"}
{"level":"info","ts":"2026-01-29T19:10:21.654907Z","caller":"traceutil/trace.go:171","msg":"trace[760174548] linearizableReadLoop","detail":"{readStateIndex:1589; appliedIndex:1575; }","duration":"2.195639675s","start":"2026-01-29T19:10:19.459262Z","end":"2026-01-29T19:10:21.654901Z","steps":["trace[760174548] 'read index received'  (duration: 1.594193355s)","trace[760174548] 'applied index is now lower than readState.Index'  (duration: 601.44548ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:10:21.65502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.363244322s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:10:21.655044Z","caller":"traceutil/trace.go:171","msg":"trace[400695738] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1517; }","duration":"6.363307364s","start":"2026-01-29T19:10:15.291731Z","end":"2026-01-29T19:10:21.655038Z","steps":["trace[400695738] 'agreement among raft nodes before linearized reading'  (duration: 6.363267153s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.655067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:15.291711Z","time spent":"6.363351004s","remote":"127.0.0.1:35186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T19:10:21.655161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.269809857s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-29T19:10:21.655183Z","caller":"traceutil/trace.go:171","msg":"trace[1572440657] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1517; }","duration":"7.269859868s","start":"2026-01-29T19:10:14.385319Z","end":"2026-01-29T19:10:21.655178Z","steps":["trace[1572440657] 'agreement among raft nodes before linearized reading'  (duration: 7.269823658s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.655201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:14.385303Z","time spent":"7.269892999s","remote":"127.0.0.1:36418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T19:10:21.662821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.557118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5912"}
{"level":"info","ts":"2026-01-29T19:10:21.662853Z","caller":"traceutil/trace.go:171","msg":"trace[402070512] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1517; }","duration":"580.62222ms","start":"2026-01-29T19:10:21.082224Z","end":"2026-01-29T19:10:21.662846Z","steps":["trace[402070512] 'agreement among raft nodes before linearized reading'  (duration: 580.558699ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.663827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:21.082204Z","time spent":"581.615979ms","remote":"127.0.0.1:36428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5935,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-01-29T19:10:21.655301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.324494978s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7045"}
{"level":"info","ts":"2026-01-29T19:10:21.663914Z","caller":"traceutil/trace.go:171","msg":"trace[552442766] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:1517; }","duration":"1.333134497s","start":"2026-01-29T19:10:20.330773Z","end":"2026-01-29T19:10:21.663908Z","steps":["trace[552442766] 'agreement among raft nodes before linearized reading'  (duration: 1.324504907s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.663929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:20.330756Z","time spent":"1.333168738s","remote":"127.0.0.1:36430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7068,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "}
{"level":"warn","ts":"2026-01-29T19:10:21.663651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.53227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-29T19:10:21.664014Z","caller":"traceutil/trace.go:171","msg":"trace[33381547] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1517; }","duration":"747.921287ms","start":"2026-01-29T19:10:20.916087Z","end":"2026-01-29T19:10:21.664009Z","steps":["trace[33381547] 'agreement among raft nodes before linearized reading'  (duration: 747.459978ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.66403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:20.916035Z","time spent":"747.989109ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":12,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T19:10:21.663715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.228074246s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.131\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:10:21.664115Z","caller":"traceutil/trace.go:171","msg":"trace[2068011107] range","detail":"{range_begin:/registry/masterleases/199.204.45.131; range_end:; response_count:0; response_revision:1517; }","duration":"1.228507054s","start":"2026-01-29T19:10:20.435603Z","end":"2026-01-29T19:10:21.66411Z","steps":["trace[2068011107] 'agreement among raft nodes before linearized reading'  (duration: 1.228092136s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.664128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:20.435585Z","time spent":"1.228538755s","remote":"127.0.0.1:34876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.131\" "}
{"level":"warn","ts":"2026-01-29T19:10:21.663733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.332292861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:10:21.664225Z","caller":"traceutil/trace.go:171","msg":"trace[1484028920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1517; }","duration":"1.332801002s","start":"2026-01-29T19:10:20.33142Z","end":"2026-01-29T19:10:21.664221Z","steps":["trace[1484028920] 'agreement among raft nodes before linearized reading'  (duration: 1.332303522s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.664239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:10:20.331412Z","time spent":"1.332823582s","remote":"127.0.0.1:34854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-29T19:10:21.794891Z","caller":"traceutil/trace.go:171","msg":"trace[2125960320] transaction","detail":"{read_only:false; response_revision:1519; number_of_response:1; }","duration":"130.352271ms","start":"2026-01-29T19:10:21.664518Z","end":"2026-01-29T19:10:21.79487Z","steps":["trace[2125960320] 'process raft request'  (duration: 106.882407ms)","trace[2125960320] 'compare'  (duration: 23.26321ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:10:21.794944Z","caller":"traceutil/trace.go:171","msg":"trace[2034145781] linearizableReadLoop","detail":"{readStateIndex:1592; appliedIndex:1590; }","duration":"126.227819ms","start":"2026-01-29T19:10:21.668692Z","end":"2026-01-29T19:10:21.79492Z","steps":["trace[2034145781] 'read index received'  (duration: 21.604965ms)","trace[2034145781] 'applied index is now lower than readState.Index'  (duration: 104.622184ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:10:21.795112Z","caller":"traceutil/trace.go:171","msg":"trace[1957403634] transaction","detail":"{read_only:false; response_revision:1520; number_of_response:1; }","duration":"126.335041ms","start":"2026-01-29T19:10:21.668768Z","end":"2026-01-29T19:10:21.795103Z","steps":["trace[1957403634] 'process raft request'  (duration: 126.065515ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:21.795249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.542445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:10:21.795273Z","caller":"traceutil/trace.go:171","msg":"trace[1455826288] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1520; }","duration":"126.599446ms","start":"2026-01-29T19:10:21.668666Z","end":"2026-01-29T19:10:21.795266Z","steps":["trace[1455826288] 'agreement among raft nodes before linearized reading'  (duration: 126.534855ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:10:23.315197Z","caller":"traceutil/trace.go:171","msg":"trace[939687478] transaction","detail":"{read_only:false; response_revision:1542; number_of_response:1; }","duration":"101.565463ms","start":"2026-01-29T19:10:23.213605Z","end":"2026-01-29T19:10:23.31517Z","steps":["trace[939687478] 'process raft request'  (duration: 35.007221ms)","trace[939687478] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/events/kube-system/kube-vip-instance.188f49588a7cc4a1; req_size:693; } (duration: 66.216495ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:10:23.459717Z","caller":"traceutil/trace.go:171","msg":"trace[2053642054] transaction","detail":"{read_only:false; response_revision:1543; number_of_response:1; }","duration":"112.793244ms","start":"2026-01-29T19:10:23.346908Z","end":"2026-01-29T19:10:23.459701Z","steps":["trace[2053642054] 'process raft request'  (duration: 112.683702ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:10:23.736316Z","caller":"traceutil/trace.go:171","msg":"trace[2049855310] transaction","detail":"{read_only:false; response_revision:1549; number_of_response:1; }","duration":"127.109647ms","start":"2026-01-29T19:10:23.609186Z","end":"2026-01-29T19:10:23.736295Z","steps":["trace[2049855310] 'process raft request'  (duration: 82.305674ms)","trace[2049855310] 'compare'  (duration: 44.692111ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:10:23.736561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.181234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-01-29T19:10:23.736585Z","caller":"traceutil/trace.go:171","msg":"trace[965587277] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:1549; }","duration":"108.263575ms","start":"2026-01-29T19:10:23.628316Z","end":"2026-01-29T19:10:23.73658Z","steps":["trace[965587277] 'agreement among raft nodes before linearized reading'  (duration: 108.191654ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:24.333343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.379306ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163062126948670 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1517 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-29T19:10:24.333449Z","caller":"traceutil/trace.go:171","msg":"trace[740911531] linearizableReadLoop","detail":"{readStateIndex:1630; appliedIndex:1628; }","duration":"233.544086ms","start":"2026-01-29T19:10:24.099897Z","end":"2026-01-29T19:10:24.333441Z","steps":["trace[740911531] 'read index received'  (duration: 120.323244ms)","trace[740911531] 'applied index is now lower than readState.Index'  (duration: 113.220252ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:10:24.333695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.797681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"}
{"level":"info","ts":"2026-01-29T19:10:24.333717Z","caller":"traceutil/trace.go:171","msg":"trace[814948863] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:1556; }","duration":"233.844792ms","start":"2026-01-29T19:10:24.099867Z","end":"2026-01-29T19:10:24.333711Z","steps":["trace[814948863] 'agreement among raft nodes before linearized reading'  (duration: 233.767851ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:10:24.333813Z","caller":"traceutil/trace.go:171","msg":"trace[1465501111] transaction","detail":"{read_only:false; response_revision:1555; number_of_response:1; }","duration":"292.847624ms","start":"2026-01-29T19:10:24.04096Z","end":"2026-01-29T19:10:24.333807Z","steps":["trace[1465501111] 'process raft request'  (duration: 179.957078ms)","trace[1465501111] 'compare'  (duration: 112.177522ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:10:24.333857Z","caller":"traceutil/trace.go:171","msg":"trace[1568706809] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"291.184952ms","start":"2026-01-29T19:10:24.042666Z","end":"2026-01-29T19:10:24.333851Z","steps":["trace[1568706809] 'process raft request'  (duration: 290.735003ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:24.333999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.067246ms","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-29T19:10:24.334017Z","caller":"traceutil/trace.go:171","msg":"trace[2130620776] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:1556; }","duration":"234.093137ms","start":"2026-01-29T19:10:24.09992Z","end":"2026-01-29T19:10:24.334013Z","steps":["trace[2130620776] 'agreement among raft nodes before linearized reading'  (duration: 234.046876ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:24.334121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.247439ms","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-29T19:10:24.334138Z","caller":"traceutil/trace.go:171","msg":"trace[896257945] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:1556; }","duration":"195.295421ms","start":"2026-01-29T19:10:24.138838Z","end":"2026-01-29T19:10:24.334134Z","steps":["trace[896257945] 'agreement among raft nodes before linearized reading'  (duration: 195.230859ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:24.334244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.677295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-01-29T19:10:24.33426Z","caller":"traceutil/trace.go:171","msg":"trace[567328645] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1556; }","duration":"206.695125ms","start":"2026-01-29T19:10:24.127561Z","end":"2026-01-29T19:10:24.334257Z","steps":["trace[567328645] 'agreement among raft nodes before linearized reading'  (duration: 206.645184ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:24.334312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.658129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"}
{"level":"info","ts":"2026-01-29T19:10:24.334327Z","caller":"traceutil/trace.go:171","msg":"trace[2059871773] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:1556; }","duration":"230.677939ms","start":"2026-01-29T19:10:24.103646Z","end":"2026-01-29T19:10:24.334324Z","steps":["trace[2059871773] 'agreement among raft nodes before linearized reading'  (duration: 230.642649ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:24.334401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.773742ms","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-29T19:10:24.334417Z","caller":"traceutil/trace.go:171","msg":"trace[2071543450] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:1556; }","duration":"230.794412ms","start":"2026-01-29T19:10:24.103619Z","end":"2026-01-29T19:10:24.334414Z","steps":["trace[2071543450] 'agreement among raft nodes before linearized reading'  (duration: 230.755621ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:24.334492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.876353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"}
{"level":"info","ts":"2026-01-29T19:10:24.334507Z","caller":"traceutil/trace.go:171","msg":"trace[748909322] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:1556; }","duration":"230.897054ms","start":"2026-01-29T19:10:24.103607Z","end":"2026-01-29T19:10:24.334504Z","steps":["trace[748909322] 'agreement among raft nodes before linearized reading'  (duration: 230.857623ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:24.334579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.975035ms","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-29T19:10:24.334594Z","caller":"traceutil/trace.go:171","msg":"trace[329690051] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:1556; }","duration":"231.006535ms","start":"2026-01-29T19:10:24.103585Z","end":"2026-01-29T19:10:24.334591Z","steps":["trace[329690051] 'agreement among raft nodes before linearized reading'  (duration: 230.970145ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:24.334683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.115268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"}
{"level":"info","ts":"2026-01-29T19:10:24.334699Z","caller":"traceutil/trace.go:171","msg":"trace[1767162123] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:1556; }","duration":"231.140099ms","start":"2026-01-29T19:10:24.103555Z","end":"2026-01-29T19:10:24.334695Z","steps":["trace[1767162123] 'agreement among raft nodes before linearized reading'  (duration: 231.083177ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:24.334797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.409663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"}
{"level":"info","ts":"2026-01-29T19:10:24.334813Z","caller":"traceutil/trace.go:171","msg":"trace[1030297236] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:1556; }","duration":"232.425244ms","start":"2026-01-29T19:10:24.102384Z","end":"2026-01-29T19:10:24.334809Z","steps":["trace[1030297236] 'agreement among raft nodes before linearized reading'  (duration: 232.390223ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:10:24.334881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.938554ms","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-29T19:10:24.334906Z","caller":"traceutil/trace.go:171","msg":"trace[1435542248] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:1556; }","duration":"234.953694ms","start":"2026-01-29T19:10:24.09994Z","end":"2026-01-29T19:10:24.334893Z","steps":["trace[1435542248] 'agreement among raft nodes before linearized reading'  (duration: 234.917124ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:10:25.004393Z","caller":"traceutil/trace.go:171","msg":"trace[535247268] transaction","detail":"{read_only:false; response_revision:1566; number_of_response:1; }","duration":"101.040503ms","start":"2026-01-29T19:10:24.903336Z","end":"2026-01-29T19:10:25.004376Z","steps":["trace[535247268] 'process raft request'  (duration: 100.865389ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:11:12.48662Z","caller":"traceutil/trace.go:171","msg":"trace[1924723824] transaction","detail":"{read_only:false; response_revision:1781; number_of_response:1; }","duration":"137.854568ms","start":"2026-01-29T19:11:12.348737Z","end":"2026-01-29T19:11:12.486592Z","steps":["trace[1924723824] 'process raft request'  (duration: 133.582754ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:11:51.380086Z","caller":"traceutil/trace.go:171","msg":"trace[881790105] linearizableReadLoop","detail":"{readStateIndex:2047; appliedIndex:2046; }","duration":"331.346668ms","start":"2026-01-29T19:11:51.048717Z","end":"2026-01-29T19:11:51.380064Z","steps":["trace[881790105] 'read index received'  (duration: 331.143664ms)","trace[881790105] 'applied index is now lower than readState.Index'  (duration: 202.124µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:11:51.380382Z","caller":"traceutil/trace.go:171","msg":"trace[1278224655] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"333.355198ms","start":"2026-01-29T19:11:51.047013Z","end":"2026-01-29T19:11:51.380369Z","steps":["trace[1278224655] 'process raft request'  (duration: 332.892199ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:11:51.381501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:11:51.047003Z","time spent":"334.418589ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1943 > 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-29T19:11:51.380568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.445004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"}
{"level":"info","ts":"2026-01-29T19:11:51.381822Z","caller":"traceutil/trace.go:171","msg":"trace[1964630797] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:1954; }","duration":"280.766331ms","start":"2026-01-29T19:11:51.101041Z","end":"2026-01-29T19:11:51.381808Z","steps":["trace[1964630797] 'agreement among raft nodes before linearized reading'  (duration: 279.432924ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:11:51.380749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.024421ms","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-29T19:11:51.382225Z","caller":"traceutil/trace.go:171","msg":"trace[1751457102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1954; }","duration":"333.508961ms","start":"2026-01-29T19:11:51.048704Z","end":"2026-01-29T19:11:51.382213Z","steps":["trace[1751457102] 'agreement among raft nodes before linearized reading'  (duration: 331.9419ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:11:51.382346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:11:51.048699Z","time spent":"333.630333ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-29T19:11:51.380824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.282451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/ceph-csi-rbd-provisioner-http-metrics\" ","response":"range_response_count:1 size:1193"}
{"level":"info","ts":"2026-01-29T19:11:51.382826Z","caller":"traceutil/trace.go:171","msg":"trace[1148572505] range","detail":"{range_begin:/registry/services/specs/kube-system/ceph-csi-rbd-provisioner-http-metrics; range_end:; response_count:1; response_revision:1954; }","duration":"278.26412ms","start":"2026-01-29T19:11:51.104523Z","end":"2026-01-29T19:11:51.382787Z","steps":["trace[1148572505] 'agreement among raft nodes before linearized reading'  (duration: 276.24514ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:11:51.568647Z","caller":"traceutil/trace.go:171","msg":"trace[2066812342] linearizableReadLoop","detail":"{readStateIndex:2048; appliedIndex:2047; }","duration":"177.142745ms","start":"2026-01-29T19:11:51.391485Z","end":"2026-01-29T19:11:51.568628Z","steps":["trace[2066812342] 'read index received'  (duration: 176.994672ms)","trace[2066812342] 'applied index is now lower than readState.Index'  (duration: 147.293µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:11:51.569397Z","caller":"traceutil/trace.go:171","msg":"trace[202463469] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"178.161476ms","start":"2026-01-29T19:11:51.39122Z","end":"2026-01-29T19:11:51.569382Z","steps":["trace[202463469] 'process raft request'  (duration: 177.308668ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:11:51.56982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.315979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/ceph-csi-rbd-provisioner-http-metrics\" ","response":"range_response_count:1 size:1193"}
{"level":"info","ts":"2026-01-29T19:11:51.570133Z","caller":"traceutil/trace.go:171","msg":"trace[1696760522] range","detail":"{range_begin:/registry/services/specs/kube-system/ceph-csi-rbd-provisioner-http-metrics; range_end:; response_count:1; response_revision:1955; }","duration":"178.650606ms","start":"2026-01-29T19:11:51.391467Z","end":"2026-01-29T19:11:51.570118Z","steps":["trace[1696760522] 'agreement among raft nodes before linearized reading'  (duration: 178.228068ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:11:51.571669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.553646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"}
{"level":"info","ts":"2026-01-29T19:11:51.571738Z","caller":"traceutil/trace.go:171","msg":"trace[544561041] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:1955; }","duration":"132.650267ms","start":"2026-01-29T19:11:51.439076Z","end":"2026-01-29T19:11:51.571726Z","steps":["trace[544561041] 'agreement among raft nodes before linearized reading'  (duration: 132.531995ms)"],"step_count":1}