{"level":"warn","ts":"2026-02-25T19:49:52.201762Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T19:49:52.202063Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.209:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.209:2380","--initial-cluster=instance=https://162.253.55.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.209:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-02-25T19:49:52.202249Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T19:49:52.20227Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.209:2380"]}
{"level":"info","ts":"2026-02-25T19:49:52.202293Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-25T19:49:52.203402Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"]}
{"level":"info","ts":"2026-02-25T19:49:52.203817Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.209:2380"],"listen-peer-urls":["https://162.253.55.209:2380"],"advertise-client-urls":["https://162.253.55.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.209:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-02-25T19:49:52.208061Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.998449ms"}
{"level":"info","ts":"2026-02-25T19:49:52.259067Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"53de2bdd9aa7b793","cluster-id":"385802231390d48c"}
{"level":"info","ts":"2026-02-25T19:49:52.259174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T19:49:52.2592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became follower at term 0"}
{"level":"info","ts":"2026-02-25T19:49:52.259217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 53de2bdd9aa7b793 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T19:49:52.259226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became follower at term 1"}
{"level":"info","ts":"2026-02-25T19:49:52.259271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=(6043315980760233875)"}
{"level":"warn","ts":"2026-02-25T19:49:52.277465Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T19:49:52.279111Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T19:49:52.280811Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-02-25T19:49:52.284821Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"53de2bdd9aa7b793","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T19:49:52.284947Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"53de2bdd9aa7b793","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T19:49:52.285011Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-25T19:49:52.285138Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-25T19:49:52.285147Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-25T19:49:52.286257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=(6043315980760233875)"}
{"level":"info","ts":"2026-02-25T19:49:52.286409Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"385802231390d48c","local-member-id":"53de2bdd9aa7b793","added-peer-id":"53de2bdd9aa7b793","added-peer-peer-urls":["https://162.253.55.209:2380"]}
{"level":"info","ts":"2026-02-25T19:49:52.295478Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-25T19:49:52.295563Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.209:2380"}
{"level":"info","ts":"2026-02-25T19:49:52.295607Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.209:2380"}
{"level":"info","ts":"2026-02-25T19:49:52.295727Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"53de2bdd9aa7b793","initial-advertise-peer-urls":["https://162.253.55.209:2380"],"listen-peer-urls":["https://162.253.55.209:2380"],"advertise-client-urls":["https://162.253.55.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T19:49:52.295779Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T19:49:52.562315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T19:49:52.562365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T19:49:52.562388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 received MsgPreVoteResp from 53de2bdd9aa7b793 at term 1"}
{"level":"info","ts":"2026-02-25T19:49:52.562399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became candidate at term 2"}
{"level":"info","ts":"2026-02-25T19:49:52.562405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 received MsgVoteResp from 53de2bdd9aa7b793 at term 2"}
{"level":"info","ts":"2026-02-25T19:49:52.562413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became leader at term 2"}
{"level":"info","ts":"2026-02-25T19:49:52.56242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 53de2bdd9aa7b793 elected leader 53de2bdd9aa7b793 at term 2"}
{"level":"info","ts":"2026-02-25T19:49:52.563206Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"53de2bdd9aa7b793","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.209:2379]}","request-path":"/0/members/53de2bdd9aa7b793/attributes","cluster-id":"385802231390d48c","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T19:49:52.563324Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T19:49:52.563429Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T19:49:52.563634Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:49:52.563778Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T19:49:52.563795Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T19:49:52.56449Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"385802231390d48c","local-member-id":"53de2bdd9aa7b793","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:49:52.564591Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:49:52.564633Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:49:52.565495Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-25T19:49:52.566706Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.209:2379"}
{"level":"info","ts":"2026-02-25T19:50:17.355539Z","caller":"traceutil/trace.go:171","msg":"trace[756184941] linearizableReadLoop","detail":"{readStateIndex:481; appliedIndex:480; }","duration":"386.559797ms","start":"2026-02-25T19:50:16.968959Z","end":"2026-02-25T19:50:17.355519Z","steps":["trace[756184941] 'read index received'  (duration: 386.408504ms)","trace[756184941] 'applied index is now lower than readState.Index'  (duration: 150.573µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:50:17.355587Z","caller":"traceutil/trace.go:171","msg":"trace[1703241139] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"630.139923ms","start":"2026-02-25T19:50:16.725418Z","end":"2026-02-25T19:50:17.355558Z","steps":["trace[1703241139] 'process raft request'  (duration: 630.0026ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:17.355651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.67883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T19:50:17.355704Z","caller":"traceutil/trace.go:171","msg":"trace[1171837298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:465; }","duration":"386.786313ms","start":"2026-02-25T19:50:16.968909Z","end":"2026-02-25T19:50:17.355695Z","steps":["trace[1171837298] 'agreement among raft nodes before linearized reading'  (duration: 386.69419ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:17.355728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:16.968888Z","time spent":"386.833394ms","remote":"127.0.0.1:46688","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-02-25T19:50:17.356127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:16.725408Z","time spent":"630.240745ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:460 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-25T19:50:22.569179Z","caller":"traceutil/trace.go:171","msg":"trace[164642323] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:528; }","duration":"155.25194ms","start":"2026-02-25T19:50:22.413903Z","end":"2026-02-25T19:50:22.569155Z","steps":["trace[164642323] 'read index received'  (duration: 155.159338ms)","trace[164642323] 'applied index is now lower than readState.Index'  (duration: 91.642µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:50:22.569425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.503577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:50:22.569485Z","caller":"traceutil/trace.go:171","msg":"trace[1581127260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"155.62571ms","start":"2026-02-25T19:50:22.413845Z","end":"2026-02-25T19:50:22.56947Z","steps":["trace[1581127260] 'agreement among raft nodes before linearized reading'  (duration: 155.420375ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:22.569603Z","caller":"traceutil/trace.go:171","msg":"trace[935185878] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"170.111893ms","start":"2026-02-25T19:50:22.399415Z","end":"2026-02-25T19:50:22.569527Z","steps":["trace[935185878] 'process raft request'  (duration: 169.602631ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:23.765728Z","caller":"traceutil/trace.go:171","msg":"trace[803093330] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"387.006448ms","start":"2026-02-25T19:50:23.378682Z","end":"2026-02-25T19:50:23.765689Z","steps":["trace[803093330] 'read index received'  (duration: 386.638199ms)","trace[803093330] 'applied index is now lower than readState.Index'  (duration: 366.919µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:50:23.765914Z","caller":"traceutil/trace.go:171","msg":"trace[1374466787] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"730.499964ms","start":"2026-02-25T19:50:23.035369Z","end":"2026-02-25T19:50:23.765869Z","steps":["trace[1374466787] 'process raft request'  (duration: 730.057414ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:23.766079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.351496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T19:50:23.766129Z","caller":"traceutil/trace.go:171","msg":"trace[1835312737] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:513; }","duration":"387.472319ms","start":"2026-02-25T19:50:23.378639Z","end":"2026-02-25T19:50:23.766112Z","steps":["trace[1835312737] 'agreement among raft nodes before linearized reading'  (duration: 387.252764ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:23.766115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:23.035331Z","time spent":"730.689229ms","remote":"127.0.0.1:46564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4567,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:410 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4533 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-02-25T19:50:23.766173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:23.378614Z","time spent":"387.549952ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T19:50:23.766346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.013287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T19:50:23.766592Z","caller":"traceutil/trace.go:171","msg":"trace[1198104351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"312.304614ms","start":"2026-02-25T19:50:23.454265Z","end":"2026-02-25T19:50:23.766569Z","steps":["trace[1198104351] 'agreement among raft nodes before linearized reading'  (duration: 311.907455ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:23.76664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:23.454245Z","time spent":"312.382406ms","remote":"127.0.0.1:46688","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-02-25T19:50:24.046463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.711536ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088700082588001 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:510 > 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-02-25T19:50:24.046627Z","caller":"traceutil/trace.go:171","msg":"trace[236540886] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"271.951969ms","start":"2026-02-25T19:50:23.774663Z","end":"2026-02-25T19:50:24.046615Z","steps":["trace[236540886] 'process raft request'  (duration: 271.924649ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:24.046796Z","caller":"traceutil/trace.go:171","msg":"trace[456409548] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"274.141383ms","start":"2026-02-25T19:50:23.772645Z","end":"2026-02-25T19:50:24.046787Z","steps":["trace[456409548] 'process raft request'  (duration: 73.910404ms)","trace[456409548] 'compare'  (duration: 199.47306ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:50:24.046905Z","caller":"traceutil/trace.go:171","msg":"trace[1510249561] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"273.598349ms","start":"2026-02-25T19:50:23.773299Z","end":"2026-02-25T19:50:24.046897Z","steps":["trace[1510249561] 'process raft request'  (duration: 273.252741ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:30.222111Z","caller":"traceutil/trace.go:171","msg":"trace[1373829419] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:549; }","duration":"136.111793ms","start":"2026-02-25T19:50:30.085958Z","end":"2026-02-25T19:50:30.22207Z","steps":["trace[1373829419] 'read index received'  (duration: 135.922459ms)","trace[1373829419] 'applied index is now lower than readState.Index'  (duration: 188.114µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:50:30.222292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.297638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-25T19:50:30.22242Z","caller":"traceutil/trace.go:171","msg":"trace[201027803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:532; }","duration":"136.488512ms","start":"2026-02-25T19:50:30.085906Z","end":"2026-02-25T19:50:30.222394Z","steps":["trace[201027803] 'agreement among raft nodes before linearized reading'  (duration: 136.306258ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:30.222416Z","caller":"traceutil/trace.go:171","msg":"trace[1405877086] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"144.671302ms","start":"2026-02-25T19:50:30.0777Z","end":"2026-02-25T19:50:30.222371Z","steps":["trace[1405877086] 'process raft request'  (duration: 144.17265ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:30.282994Z","caller":"traceutil/trace.go:171","msg":"trace[1810792504] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"196.951029ms","start":"2026-02-25T19:50:30.086007Z","end":"2026-02-25T19:50:30.282958Z","steps":["trace[1810792504] 'process raft request'  (duration: 196.782635ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:30.493619Z","caller":"traceutil/trace.go:171","msg":"trace[182706244] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"124.947ms","start":"2026-02-25T19:50:30.368647Z","end":"2026-02-25T19:50:30.493594Z","steps":["trace[182706244] 'read index received'  (duration: 124.727345ms)","trace[182706244] 'applied index is now lower than readState.Index'  (duration: 218.615µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:50:30.494011Z","caller":"traceutil/trace.go:171","msg":"trace[341870454] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"264.573619ms","start":"2026-02-25T19:50:30.229337Z","end":"2026-02-25T19:50:30.49391Z","steps":["trace[341870454] 'process raft request'  (duration: 264.112538ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:30.494214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.537185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5sj6l\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-02-25T19:50:30.494322Z","caller":"traceutil/trace.go:171","msg":"trace[449424520] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5sj6l; range_end:; response_count:1; response_revision:534; }","duration":"125.655577ms","start":"2026-02-25T19:50:30.36864Z","end":"2026-02-25T19:50:30.494295Z","steps":["trace[449424520] 'agreement among raft nodes before linearized reading'  (duration: 125.376281ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:30.909495Z","caller":"traceutil/trace.go:171","msg":"trace[391548774] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:552; }","duration":"297.728608ms","start":"2026-02-25T19:50:30.611739Z","end":"2026-02-25T19:50:30.909468Z","steps":["trace[391548774] 'read index received'  (duration: 297.483012ms)","trace[391548774] 'applied index is now lower than readState.Index'  (duration: 244.066µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:50:30.909593Z","caller":"traceutil/trace.go:171","msg":"trace[1370702966] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"397.73632ms","start":"2026-02-25T19:50:30.511799Z","end":"2026-02-25T19:50:30.909536Z","steps":["trace[1370702966] 'process raft request'  (duration: 397.445893ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:30.909745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.991875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-25T19:50:30.909797Z","caller":"traceutil/trace.go:171","msg":"trace[15854846] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:535; }","duration":"298.105098ms","start":"2026-02-25T19:50:30.611676Z","end":"2026-02-25T19:50:30.909781Z","steps":["trace[15854846] 'agreement among raft nodes before linearized reading'  (duration: 297.901883ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:30.909849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:30.511772Z","time spent":"397.952955ms","remote":"127.0.0.1:46572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-5sj6l\" mod_revision:505 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-5sj6l\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-5sj6l\" > >"}
{"level":"warn","ts":"2026-02-25T19:50:32.787809Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088700082588057,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T19:50:32.974144Z","caller":"traceutil/trace.go:171","msg":"trace[189306119] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:555; }","duration":"686.626733ms","start":"2026-02-25T19:50:32.287495Z","end":"2026-02-25T19:50:32.974121Z","steps":["trace[189306119] 'read index received'  (duration: 686.424328ms)","trace[189306119] 'applied index is now lower than readState.Index'  (duration: 201.535µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:50:32.974365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.856738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-25T19:50:32.974452Z","caller":"traceutil/trace.go:171","msg":"trace[660708614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:537; }","duration":"687.006272ms","start":"2026-02-25T19:50:32.28743Z","end":"2026-02-25T19:50:32.974436Z","steps":["trace[660708614] 'agreement among raft nodes before linearized reading'  (duration: 686.820368ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:32.974496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:32.287407Z","time spent":"687.078704ms","remote":"127.0.0.1:46688","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-02-25T19:50:32.97457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.8144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-25T19:50:32.974631Z","caller":"traceutil/trace.go:171","msg":"trace[1059409610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:537; }","duration":"476.894713ms","start":"2026-02-25T19:50:32.497715Z","end":"2026-02-25T19:50:32.97461Z","steps":["trace[1059409610] 'agreement among raft nodes before linearized reading'  (duration: 476.742759ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:32.974671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:32.497699Z","time spent":"476.963244ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-25T19:50:32.974803Z","caller":"traceutil/trace.go:171","msg":"trace[1333883710] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"741.966654ms","start":"2026-02-25T19:50:32.232813Z","end":"2026-02-25T19:50:32.97478Z","steps":["trace[1333883710] 'process raft request'  (duration: 741.171195ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:32.974957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:32.232781Z","time spent":"742.096437ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:532 > 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":"warn","ts":"2026-02-25T19:50:32.974385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.857357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:50:32.975677Z","caller":"traceutil/trace.go:171","msg":"trace[535051319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"563.176709ms","start":"2026-02-25T19:50:32.412464Z","end":"2026-02-25T19:50:32.975641Z","steps":["trace[535051319] 'agreement among raft nodes before linearized reading'  (duration: 561.845306ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:32.975778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:32.412446Z","time spent":"563.296422ms","remote":"127.0.0.1:46438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:50:33.160889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.499461ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088700082588062 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:533 > 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-02-25T19:50:33.161185Z","caller":"traceutil/trace.go:171","msg":"trace[1283060325] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:556; }","duration":"149.029178ms","start":"2026-02-25T19:50:33.012139Z","end":"2026-02-25T19:50:33.161168Z","steps":["trace[1283060325] 'read index received'  (duration: 35.180839ms)","trace[1283060325] 'applied index is now lower than readState.Index'  (duration: 113.847279ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:50:33.161419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.271314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-25T19:50:33.161457Z","caller":"traceutil/trace.go:171","msg":"trace[257813398] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:539; }","duration":"149.322855ms","start":"2026-02-25T19:50:33.012124Z","end":"2026-02-25T19:50:33.161447Z","steps":["trace[257813398] 'agreement among raft nodes before linearized reading'  (duration: 149.153661ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:33.161719Z","caller":"traceutil/trace.go:171","msg":"trace[1837235945] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"182.754952ms","start":"2026-02-25T19:50:32.978942Z","end":"2026-02-25T19:50:33.161697Z","steps":["trace[1837235945] 'process raft request'  (duration: 68.36501ms)","trace[1837235945] 'compare'  (duration: 113.380047ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:50:33.161717Z","caller":"traceutil/trace.go:171","msg":"trace[20140620] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"181.938262ms","start":"2026-02-25T19:50:32.979475Z","end":"2026-02-25T19:50:33.161413Z","steps":["trace[20140620] 'process raft request'  (duration: 181.506332ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:34.992622Z","caller":"traceutil/trace.go:171","msg":"trace[1832836794] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"469.619825ms","start":"2026-02-25T19:50:34.522968Z","end":"2026-02-25T19:50:34.992588Z","steps":["trace[1832836794] 'process raft request'  (duration: 469.403359ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:34.992788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:34.522938Z","time spent":"469.783628ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:50:51.474332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.968033ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088700082588406 > lease_revoke:<id:37939c9659c809e0>","response":"size:27"}
{"level":"info","ts":"2026-02-25T19:50:51.474429Z","caller":"traceutil/trace.go:171","msg":"trace[1935154288] linearizableReadLoop","detail":"{readStateIndex:739; appliedIndex:738; }","duration":"398.172931ms","start":"2026-02-25T19:50:51.076237Z","end":"2026-02-25T19:50:51.47441Z","steps":["trace[1935154288] 'read index received'  (duration: 261.015363ms)","trace[1935154288] 'applied index is now lower than readState.Index'  (duration: 137.156008ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:50:51.47463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.936623ms","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-02-25T19:50:51.474629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.386156ms","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-02-25T19:50:51.474667Z","caller":"traceutil/trace.go:171","msg":"trace[379387461] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:715; }","duration":"393.025185ms","start":"2026-02-25T19:50:51.081631Z","end":"2026-02-25T19:50:51.474656Z","steps":["trace[379387461] 'agreement among raft nodes before linearized reading'  (duration: 392.889292ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:51.474683Z","caller":"traceutil/trace.go:171","msg":"trace[274856107] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:715; }","duration":"398.487039ms","start":"2026-02-25T19:50:51.076181Z","end":"2026-02-25T19:50:51.474668Z","steps":["trace[274856107] 'agreement among raft nodes before linearized reading'  (duration: 398.320004ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:51.474708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:51.081605Z","time spent":"393.094566ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-25T19:50:51.474823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.039807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-25T19:50:51.47486Z","caller":"traceutil/trace.go:171","msg":"trace[1934861530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:715; }","duration":"228.105819ms","start":"2026-02-25T19:50:51.246745Z","end":"2026-02-25T19:50:51.474851Z","steps":["trace[1934861530] 'agreement among raft nodes before linearized reading'  (duration: 228.016517ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:51.474716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:50:51.07616Z","time spent":"398.54953ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T19:50:51.47495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.577438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-25T19:50:51.475043Z","caller":"traceutil/trace.go:171","msg":"trace[274816808] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:715; }","duration":"214.729232ms","start":"2026-02-25T19:50:51.260292Z","end":"2026-02-25T19:50:51.475021Z","steps":["trace[274816808] 'agreement among raft nodes before linearized reading'  (duration: 214.439515ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:50:51.475041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.071352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-25T19:50:51.475136Z","caller":"traceutil/trace.go:171","msg":"trace[924805477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:715; }","duration":"231.216725ms","start":"2026-02-25T19:50:51.243898Z","end":"2026-02-25T19:50:51.475115Z","steps":["trace[924805477] 'agreement among raft nodes before linearized reading'  (duration: 230.899948ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:51.666993Z","caller":"traceutil/trace.go:171","msg":"trace[1675386803] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"187.666741ms","start":"2026-02-25T19:50:51.4793Z","end":"2026-02-25T19:50:51.666967Z","steps":["trace[1675386803] 'process raft request'  (duration: 119.686792ms)","trace[1675386803] 'compare'  (duration: 67.764524ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:50:51.66714Z","caller":"traceutil/trace.go:171","msg":"trace[53616922] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"187.572619ms","start":"2026-02-25T19:50:51.479556Z","end":"2026-02-25T19:50:51.667129Z","steps":["trace[53616922] 'process raft request'  (duration: 187.400655ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:51.667127Z","caller":"traceutil/trace.go:171","msg":"trace[216680971] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"187.777704ms","start":"2026-02-25T19:50:51.479304Z","end":"2026-02-25T19:50:51.667081Z","steps":["trace[216680971] 'process raft request'  (duration: 187.588679ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:50:51.667126Z","caller":"traceutil/trace.go:171","msg":"trace[1052653026] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"186.538304ms","start":"2026-02-25T19:50:51.480567Z","end":"2026-02-25T19:50:51.667105Z","steps":["trace[1052653026] 'process raft request'  (duration: 186.480002ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:13.888704Z","caller":"traceutil/trace.go:171","msg":"trace[958284780] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:810; }","duration":"118.682842ms","start":"2026-02-25T19:51:13.769997Z","end":"2026-02-25T19:51:13.88868Z","steps":["trace[958284780] 'read index received'  (duration: 118.628451ms)","trace[958284780] 'applied index is now lower than readState.Index'  (duration: 53.331µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:51:13.888989Z","caller":"traceutil/trace.go:171","msg":"trace[341477503] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"150.654392ms","start":"2026-02-25T19:51:13.738314Z","end":"2026-02-25T19:51:13.888968Z","steps":["trace[341477503] 'process raft request'  (duration: 150.236032ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:13.889127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.096202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T19:51:13.889171Z","caller":"traceutil/trace.go:171","msg":"trace[1025659223] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:783; }","duration":"119.170594ms","start":"2026-02-25T19:51:13.769989Z","end":"2026-02-25T19:51:13.88916Z","steps":["trace[1025659223] 'agreement among raft nodes before linearized reading'  (duration: 118.99979ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:13.889233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.779509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T19:51:13.889294Z","caller":"traceutil/trace.go:171","msg":"trace[755446728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:783; }","duration":"114.877421ms","start":"2026-02-25T19:51:13.774401Z","end":"2026-02-25T19:51:13.889278Z","steps":["trace[755446728] 'agreement among raft nodes before linearized reading'  (duration: 114.744778ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:13.889432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.68163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-02-25T19:51:13.889539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.823073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-25T19:51:13.889649Z","caller":"traceutil/trace.go:171","msg":"trace[330719646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:783; }","duration":"113.003937ms","start":"2026-02-25T19:51:13.776625Z","end":"2026-02-25T19:51:13.889629Z","steps":["trace[330719646] 'agreement among raft nodes before linearized reading'  (duration: 112.656169ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:13.889567Z","caller":"traceutil/trace.go:171","msg":"trace[270826371] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:783; }","duration":"112.947436ms","start":"2026-02-25T19:51:13.776607Z","end":"2026-02-25T19:51:13.889554Z","steps":["trace[270826371] 'agreement among raft nodes before linearized reading'  (duration: 112.665589ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:20.243543Z","caller":"traceutil/trace.go:171","msg":"trace[763343901] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"274.248851ms","start":"2026-02-25T19:51:19.96926Z","end":"2026-02-25T19:51:20.243509Z","steps":["trace[763343901] 'process raft request'  (duration: 272.11407ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:20.246675Z","caller":"traceutil/trace.go:171","msg":"trace[319199594] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"277.248373ms","start":"2026-02-25T19:51:19.969404Z","end":"2026-02-25T19:51:20.246653Z","steps":["trace[319199594] 'process raft request'  (duration: 277.12837ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:20.246802Z","caller":"traceutil/trace.go:171","msg":"trace[1676444729] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"276.118785ms","start":"2026-02-25T19:51:19.970673Z","end":"2026-02-25T19:51:20.246792Z","steps":["trace[1676444729] 'process raft request'  (duration: 275.946961ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:20.246924Z","caller":"traceutil/trace.go:171","msg":"trace[1032829660] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"275.48751ms","start":"2026-02-25T19:51:19.97143Z","end":"2026-02-25T19:51:20.246918Z","steps":["trace[1032829660] 'process raft request'  (duration: 275.326846ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:21.2358Z","caller":"traceutil/trace.go:171","msg":"trace[556380072] linearizableReadLoop","detail":"{readStateIndex:835; appliedIndex:834; }","duration":"210.634399ms","start":"2026-02-25T19:51:21.025138Z","end":"2026-02-25T19:51:21.235772Z","steps":["trace[556380072] 'read index received'  (duration: 121.082549ms)","trace[556380072] 'applied index is now lower than readState.Index'  (duration: 89.55009ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:51:21.236141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.978787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T19:51:21.236174Z","caller":"traceutil/trace.go:171","msg":"trace[1140359484] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:805; }","duration":"211.078639ms","start":"2026-02-25T19:51:21.025086Z","end":"2026-02-25T19:51:21.236165Z","steps":["trace[1140359484] 'agreement among raft nodes before linearized reading'  (duration: 210.975147ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:22.18518Z","caller":"traceutil/trace.go:171","msg":"trace[1431500977] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"212.257727ms","start":"2026-02-25T19:51:21.972898Z","end":"2026-02-25T19:51:22.185156Z","steps":["trace[1431500977] 'process raft request'  (duration: 212.101434ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:22.596646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.813687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-25T19:51:22.596711Z","caller":"traceutil/trace.go:171","msg":"trace[1247486223] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:806; }","duration":"349.94944ms","start":"2026-02-25T19:51:22.246749Z","end":"2026-02-25T19:51:22.596698Z","steps":["trace[1247486223] 'range keys from in-memory index tree'  (duration: 349.597312ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:22.597074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.676301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-02-25T19:51:22.597415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:22.246726Z","time spent":"350.007572ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T19:51:22.597759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.85161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T19:51:22.597799Z","caller":"traceutil/trace.go:171","msg":"trace[1570010476] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:806; }","duration":"347.931092ms","start":"2026-02-25T19:51:22.249856Z","end":"2026-02-25T19:51:22.597787Z","steps":["trace[1570010476] 'range keys from in-memory index tree'  (duration: 346.787595ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:22.597827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:22.249836Z","time spent":"347.979224ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T19:51:22.597913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.01465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-25T19:51:22.597985Z","caller":"traceutil/trace.go:171","msg":"trace[893649999] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:806; }","duration":"347.139833ms","start":"2026-02-25T19:51:22.250825Z","end":"2026-02-25T19:51:22.597965Z","steps":["trace[893649999] 'range keys from in-memory index tree'  (duration: 345.852173ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:22.598026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:22.250805Z","time spent":"347.212356ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-25T19:51:22.597449Z","caller":"traceutil/trace.go:171","msg":"trace[1961400778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:806; }","duration":"336.225454ms","start":"2026-02-25T19:51:22.261092Z","end":"2026-02-25T19:51:22.597317Z","steps":["trace[1961400778] 'range keys from in-memory index tree'  (duration: 335.565869ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:22.598202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:22.26108Z","time spent":"337.076465ms","remote":"127.0.0.1:46688","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":"info","ts":"2026-02-25T19:51:22.761479Z","caller":"traceutil/trace.go:171","msg":"trace[91995659] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"154.900743ms","start":"2026-02-25T19:51:22.606549Z","end":"2026-02-25T19:51:22.76145Z","steps":["trace[91995659] 'process raft request'  (duration: 154.846952ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:22.761778Z","caller":"traceutil/trace.go:171","msg":"trace[675302848] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"156.366369ms","start":"2026-02-25T19:51:22.605355Z","end":"2026-02-25T19:51:22.761722Z","steps":["trace[675302848] 'process raft request'  (duration: 155.833636ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:22.762168Z","caller":"traceutil/trace.go:171","msg":"trace[45170608] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"156.728967ms","start":"2026-02-25T19:51:22.60542Z","end":"2026-02-25T19:51:22.762149Z","steps":["trace[45170608] 'process raft request'  (duration: 155.923448ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:24.028523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.615738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:51:24.028634Z","caller":"traceutil/trace.go:171","msg":"trace[1722446819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"615.783422ms","start":"2026-02-25T19:51:23.412817Z","end":"2026-02-25T19:51:24.0286Z","steps":["trace[1722446819] 'range keys from in-memory index tree'  (duration: 615.473045ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:24.028672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:23.412796Z","time spent":"615.867984ms","remote":"127.0.0.1:46438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:51:24.028534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.595744ms","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-02-25T19:51:24.028761Z","caller":"traceutil/trace.go:171","msg":"trace[1348441545] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:810; }","duration":"188.83744ms","start":"2026-02-25T19:51:23.839902Z","end":"2026-02-25T19:51:24.028739Z","steps":["trace[1348441545] 'count revisions from in-memory index tree'  (duration: 188.41611ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:24.931654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.31122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:51:24.931739Z","caller":"traceutil/trace.go:171","msg":"trace[172474426] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:812; }","duration":"120.435993ms","start":"2026-02-25T19:51:24.811284Z","end":"2026-02-25T19:51:24.93172Z","steps":["trace[172474426] 'range keys from in-memory index tree'  (duration: 120.247488ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:24.931917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.691375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-25T19:51:24.932004Z","caller":"traceutil/trace.go:171","msg":"trace[1550191120] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:812; }","duration":"164.853199ms","start":"2026-02-25T19:51:24.767129Z","end":"2026-02-25T19:51:24.931982Z","steps":["trace[1550191120] 'range keys from in-memory index tree'  (duration: 164.395338ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:24.931917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.760426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-02-25T19:51:24.932105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.305945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-25T19:51:24.932247Z","caller":"traceutil/trace.go:171","msg":"trace[353676490] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:812; }","duration":"164.526901ms","start":"2026-02-25T19:51:24.767692Z","end":"2026-02-25T19:51:24.932219Z","steps":["trace[353676490] 'range keys from in-memory index tree'  (duration: 164.03328ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:24.932135Z","caller":"traceutil/trace.go:171","msg":"trace[1533250817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:812; }","duration":"165.030193ms","start":"2026-02-25T19:51:24.76707Z","end":"2026-02-25T19:51:24.9321Z","steps":["trace[1533250817] 'range keys from in-memory index tree'  (duration: 164.332637ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:25.534627Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088700082588680,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T19:51:25.816952Z","caller":"traceutil/trace.go:171","msg":"trace[147932460] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"879.720997ms","start":"2026-02-25T19:51:24.937206Z","end":"2026-02-25T19:51:25.816927Z","steps":["trace[147932460] 'process raft request'  (duration: 879.543913ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:25.8171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:24.93718Z","time spent":"879.843171ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:809 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-25T19:51:25.817089Z","caller":"traceutil/trace.go:171","msg":"trace[1930976482] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:843; }","duration":"783.020208ms","start":"2026-02-25T19:51:25.034048Z","end":"2026-02-25T19:51:25.817068Z","steps":["trace[1930976482] 'read index received'  (duration: 782.69563ms)","trace[1930976482] 'applied index is now lower than readState.Index'  (duration: 323.448µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:51:25.817182Z","caller":"traceutil/trace.go:171","msg":"trace[839248493] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"879.158304ms","start":"2026-02-25T19:51:24.938003Z","end":"2026-02-25T19:51:25.817161Z","steps":["trace[839248493] 'process raft request'  (duration: 878.889887ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:25.817213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.161932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T19:51:25.817247Z","caller":"traceutil/trace.go:171","msg":"trace[727169177] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:815; }","duration":"783.258604ms","start":"2026-02-25T19:51:25.033978Z","end":"2026-02-25T19:51:25.817236Z","steps":["trace[727169177] 'agreement among raft nodes before linearized reading'  (duration: 783.189962ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:25.817278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:25.033947Z","time spent":"783.322735ms","remote":"127.0.0.1:46564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":29,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T19:51:25.817414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.805011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:51:25.817534Z","caller":"traceutil/trace.go:171","msg":"trace[228468376] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:815; }","duration":"403.996875ms","start":"2026-02-25T19:51:25.413514Z","end":"2026-02-25T19:51:25.817511Z","steps":["trace[228468376] 'agreement among raft nodes before linearized reading'  (duration: 403.749649ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:25.817536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.89482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.209\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-02-25T19:51:25.817601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:25.413494Z","time spent":"404.097838ms","remote":"127.0.0.1:46440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T19:51:25.817612Z","caller":"traceutil/trace.go:171","msg":"trace[1363849237] range","detail":"{range_begin:/registry/masterleases/162.253.55.209; range_end:; response_count:1; response_revision:815; }","duration":"300.054694ms","start":"2026-02-25T19:51:25.517535Z","end":"2026-02-25T19:51:25.81759Z","steps":["trace[1363849237] 'agreement among raft nodes before linearized reading'  (duration: 299.788018ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:25.817673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:25.517507Z","time spent":"300.150696ms","remote":"127.0.0.1:46456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.209\" "}
{"level":"warn","ts":"2026-02-25T19:51:25.817292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:24.937983Z","time spent":"879.246946ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:810 > 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-02-25T19:51:26.13968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.647541ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088700082588687 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:37939c9659c80c0e>","response":"size:39"}
{"level":"warn","ts":"2026-02-25T19:51:26.13984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:25.818743Z","time spent":"321.092274ms","remote":"127.0.0.1:46456","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-25T19:51:27.160461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.338116ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088700082588688 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.209\" mod_revision:788 > success:<request_put:<key:\"/registry/masterleases/162.253.55.209\" value_size:67 lease:4004716663227812878 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.209\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:51:27.160665Z","caller":"traceutil/trace.go:171","msg":"trace[543034936] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"760.470393ms","start":"2026-02-25T19:51:26.400177Z","end":"2026-02-25T19:51:27.160648Z","steps":["trace[543034936] 'process raft request'  (duration: 760.380871ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:27.160661Z","caller":"traceutil/trace.go:171","msg":"trace[981079859] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"1.019636865s","start":"2026-02-25T19:51:26.140979Z","end":"2026-02-25T19:51:27.160616Z","steps":["trace[981079859] 'process raft request'  (duration: 437.018242ms)","trace[981079859] 'compare'  (duration: 581.778423ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:51:27.160731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:26.400149Z","time spent":"760.549614ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:794 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-25T19:51:27.160802Z","caller":"traceutil/trace.go:171","msg":"trace[1872762875] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:846; }","duration":"900.740587ms","start":"2026-02-25T19:51:26.260044Z","end":"2026-02-25T19:51:27.160784Z","steps":["trace[1872762875] 'read index received'  (duration: 317.905739ms)","trace[1872762875] 'applied index is now lower than readState.Index'  (duration: 582.832958ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:51:27.160859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:26.140958Z","time spent":"1.019789128s","remote":"127.0.0.1:46456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.209\" mod_revision:788 > success:<request_put:<key:\"/registry/masterleases/162.253.55.209\" value_size:67 lease:4004716663227812878 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.209\" > >"}
{"level":"warn","ts":"2026-02-25T19:51:27.160989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.911283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T19:51:27.161028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.971677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-25T19:51:27.161037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.002144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-25T19:51:27.161076Z","caller":"traceutil/trace.go:171","msg":"trace[94398677] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:817; }","duration":"468.06414ms","start":"2026-02-25T19:51:26.692997Z","end":"2026-02-25T19:51:27.161061Z","steps":["trace[94398677] 'agreement among raft nodes before linearized reading'  (duration: 467.936237ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:27.161075Z","caller":"traceutil/trace.go:171","msg":"trace[796265275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:817; }","duration":"747.999956ms","start":"2026-02-25T19:51:26.413029Z","end":"2026-02-25T19:51:27.161029Z","steps":["trace[796265275] 'agreement among raft nodes before linearized reading'  (duration: 747.901833ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:27.161084Z","caller":"traceutil/trace.go:171","msg":"trace[1998562846] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:817; }","duration":"901.106206ms","start":"2026-02-25T19:51:26.259965Z","end":"2026-02-25T19:51:27.161071Z","steps":["trace[1998562846] 'agreement among raft nodes before linearized reading'  (duration: 900.911551ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:27.161113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:26.692971Z","time spent":"468.134671ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T19:51:27.161125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:26.259936Z","time spent":"901.182118ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T19:51:27.161131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:26.413016Z","time spent":"748.102468ms","remote":"127.0.0.1:46438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:51:27.161158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.04896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-25T19:51:27.161247Z","caller":"traceutil/trace.go:171","msg":"trace[2110484681] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:817; }","duration":"185.196233ms","start":"2026-02-25T19:51:26.976026Z","end":"2026-02-25T19:51:27.161222Z","steps":["trace[2110484681] 'agreement among raft nodes before linearized reading'  (duration: 184.906657ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:27.327428Z","caller":"traceutil/trace.go:171","msg":"trace[413449927] linearizableReadLoop","detail":"{readStateIndex:849; appliedIndex:848; }","duration":"162.444333ms","start":"2026-02-25T19:51:27.164955Z","end":"2026-02-25T19:51:27.3274Z","steps":["trace[413449927] 'read index received'  (duration: 131.821215ms)","trace[413449927] 'applied index is now lower than readState.Index'  (duration: 30.621648ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:51:27.327446Z","caller":"traceutil/trace.go:171","msg":"trace[1849389373] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"162.975495ms","start":"2026-02-25T19:51:27.164443Z","end":"2026-02-25T19:51:27.327419Z","steps":["trace[1849389373] 'process raft request'  (duration: 132.290566ms)","trace[1849389373] 'compare'  (duration: 30.427183ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:51:27.327676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.701429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T19:51:27.327721Z","caller":"traceutil/trace.go:171","msg":"trace[1368506286] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:818; }","duration":"162.78572ms","start":"2026-02-25T19:51:27.164923Z","end":"2026-02-25T19:51:27.327709Z","steps":["trace[1368506286] 'agreement among raft nodes before linearized reading'  (duration: 162.613206ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:27.409617Z","caller":"traceutil/trace.go:171","msg":"trace[1829167598] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"243.989331ms","start":"2026-02-25T19:51:27.165603Z","end":"2026-02-25T19:51:27.409593Z","steps":["trace[1829167598] 'process raft request'  (duration: 243.413517ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:27.409752Z","caller":"traceutil/trace.go:171","msg":"trace[2012743789] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"243.692085ms","start":"2026-02-25T19:51:27.166049Z","end":"2026-02-25T19:51:27.409741Z","steps":["trace[2012743789] 'process raft request'  (duration: 243.113341ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:38.154272Z","caller":"traceutil/trace.go:171","msg":"trace[322017807] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"278.539903ms","start":"2026-02-25T19:51:37.875705Z","end":"2026-02-25T19:51:38.154245Z","steps":["trace[322017807] 'process raft request'  (duration: 278.296707ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:38.159578Z","caller":"traceutil/trace.go:171","msg":"trace[1351829839] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"283.127942ms","start":"2026-02-25T19:51:37.876414Z","end":"2026-02-25T19:51:38.159542Z","steps":["trace[1351829839] 'process raft request'  (duration: 282.946778ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:39.915273Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088700082588886,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T19:51:40.064049Z","caller":"traceutil/trace.go:171","msg":"trace[1050990456] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"669.307704ms","start":"2026-02-25T19:51:39.39469Z","end":"2026-02-25T19:51:40.063998Z","steps":["trace[1050990456] 'process raft request'  (duration: 669.152691ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:40.064185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:39.394672Z","time spent":"669.443368ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:897 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-25T19:51:40.808212Z","caller":"traceutil/trace.go:171","msg":"trace[220315630] linearizableReadLoop","detail":"{readStateIndex:938; appliedIndex:936; }","duration":"1.393359921s","start":"2026-02-25T19:51:39.414825Z","end":"2026-02-25T19:51:40.808185Z","steps":["trace[220315630] 'read index received'  (duration: 649.011653ms)","trace[220315630] 'applied index is now lower than readState.Index'  (duration: 744.346788ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:51:40.808351Z","caller":"traceutil/trace.go:171","msg":"trace[1870851384] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"1.394404246s","start":"2026-02-25T19:51:39.413935Z","end":"2026-02-25T19:51:40.808339Z","steps":["trace[1870851384] 'process raft request'  (duration: 1.392703425s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:40.808537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:39.413917Z","time spent":"1.394465457s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:823 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-25T19:51:40.808874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.394037817s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T19:51:40.80893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.779047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T19:51:40.808974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.535453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-25T19:51:40.809007Z","caller":"traceutil/trace.go:171","msg":"trace[1729768523] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:903; }","duration":"214.899599ms","start":"2026-02-25T19:51:40.594086Z","end":"2026-02-25T19:51:40.808986Z","steps":["trace[1729768523] 'agreement among raft nodes before linearized reading'  (duration: 214.759606ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:40.809037Z","caller":"traceutil/trace.go:171","msg":"trace[42544929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:903; }","duration":"646.710697ms","start":"2026-02-25T19:51:40.16231Z","end":"2026-02-25T19:51:40.809021Z","steps":["trace[42544929] 'agreement among raft nodes before linearized reading'  (duration: 646.497122ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:40.809021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.342744007s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-02-25T19:51:40.809074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:40.162258Z","time spent":"646.808909ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T19:51:40.809105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.001688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T19:51:40.809135Z","caller":"traceutil/trace.go:171","msg":"trace[781451045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:903; }","duration":"648.07439ms","start":"2026-02-25T19:51:40.161055Z","end":"2026-02-25T19:51:40.809129Z","steps":["trace[781451045] 'agreement among raft nodes before linearized reading'  (duration: 647.925516ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:40.80916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:40.161031Z","time spent":"648.12323ms","remote":"127.0.0.1:46688","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-02-25T19:51:40.809183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.337759949s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-25T19:51:40.809213Z","caller":"traceutil/trace.go:171","msg":"trace[1364385976] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:903; }","duration":"1.33783247s","start":"2026-02-25T19:51:39.471373Z","end":"2026-02-25T19:51:40.809205Z","steps":["trace[1364385976] 'agreement among raft nodes before linearized reading'  (duration: 1.337751269s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:40.8091Z","caller":"traceutil/trace.go:171","msg":"trace[1410996977] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:903; }","duration":"1.34287863s","start":"2026-02-25T19:51:39.4662Z","end":"2026-02-25T19:51:40.809079Z","steps":["trace[1410996977] 'agreement among raft nodes before linearized reading'  (duration: 1.342610674s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:40.809256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:39.466175Z","time spent":"1.343075655s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T19:51:40.809258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:39.47135Z","time spent":"1.337899161s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-25T19:51:40.809221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.064714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:51:40.809351Z","caller":"traceutil/trace.go:171","msg":"trace[124589457] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:903; }","duration":"530.239298ms","start":"2026-02-25T19:51:40.2791Z","end":"2026-02-25T19:51:40.809339Z","steps":["trace[124589457] 'agreement among raft nodes before linearized reading'  (duration: 530.095524ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:40.808953Z","caller":"traceutil/trace.go:171","msg":"trace[2087829006] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:903; }","duration":"1.39416619s","start":"2026-02-25T19:51:39.414765Z","end":"2026-02-25T19:51:40.808932Z","steps":["trace[2087829006] 'agreement among raft nodes before linearized reading'  (duration: 1.394027317s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:40.809381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:40.279081Z","time spent":"530.291679ms","remote":"127.0.0.1:46800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T19:51:40.809395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:39.41474Z","time spent":"1.394641992s","remote":"127.0.0.1:46438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T19:51:54.394978Z","caller":"traceutil/trace.go:171","msg":"trace[382922250] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"247.017944ms","start":"2026-02-25T19:51:54.147921Z","end":"2026-02-25T19:51:54.394939Z","steps":["trace[382922250] 'process raft request'  (duration: 246.848259ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:57.139088Z","caller":"traceutil/trace.go:171","msg":"trace[1354842198] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"239.713069ms","start":"2026-02-25T19:51:56.899343Z","end":"2026-02-25T19:51:57.139056Z","steps":["trace[1354842198] 'process raft request'  (duration: 195.730574ms)","trace[1354842198] 'compare'  (duration: 43.786041ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:51:57.139389Z","caller":"traceutil/trace.go:171","msg":"trace[863478515] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"239.399572ms","start":"2026-02-25T19:51:56.899957Z","end":"2026-02-25T19:51:57.139357Z","steps":["trace[863478515] 'process raft request'  (duration: 239.045233ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:57.141559Z","caller":"traceutil/trace.go:171","msg":"trace[547617195] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"216.798733ms","start":"2026-02-25T19:51:56.924737Z","end":"2026-02-25T19:51:57.141535Z","steps":["trace[547617195] 'process raft request'  (duration: 216.67464ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:57.579014Z","caller":"traceutil/trace.go:171","msg":"trace[61571105] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"216.807825ms","start":"2026-02-25T19:51:57.362182Z","end":"2026-02-25T19:51:57.57899Z","steps":["trace[61571105] 'process raft request'  (duration: 216.683702ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:57.579272Z","caller":"traceutil/trace.go:171","msg":"trace[106820090] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1011; }","duration":"166.952179ms","start":"2026-02-25T19:51:57.412297Z","end":"2026-02-25T19:51:57.579249Z","steps":["trace[106820090] 'read index received'  (duration: 166.944069ms)","trace[106820090] 'applied index is now lower than readState.Index'  (duration: 6.03µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:51:57.579441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.128774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:51:57.57952Z","caller":"traceutil/trace.go:171","msg":"trace[1559009445] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:972; }","duration":"167.270517ms","start":"2026-02-25T19:51:57.412232Z","end":"2026-02-25T19:51:57.579503Z","steps":["trace[1559009445] 'agreement among raft nodes before linearized reading'  (duration: 167.093863ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:58.216868Z","caller":"traceutil/trace.go:171","msg":"trace[932738810] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"508.46494ms","start":"2026-02-25T19:51:57.708381Z","end":"2026-02-25T19:51:58.216846Z","steps":["trace[932738810] 'process raft request'  (duration: 470.416965ms)","trace[932738810] 'compare'  (duration: 37.772638ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:51:58.216992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:57.70836Z","time spent":"508.560422ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:924 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-25T19:51:58.682834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.583461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:51:58.682905Z","caller":"traceutil/trace.go:171","msg":"trace[1672630719] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:973; }","duration":"269.692154ms","start":"2026-02-25T19:51:58.413197Z","end":"2026-02-25T19:51:58.682889Z","steps":["trace[1672630719] 'range keys from in-memory index tree'  (duration: 269.52075ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:58.68309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.322189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T19:51:58.683144Z","caller":"traceutil/trace.go:171","msg":"trace[13261680] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:973; }","duration":"270.428491ms","start":"2026-02-25T19:51:58.412702Z","end":"2026-02-25T19:51:58.68313Z","steps":["trace[13261680] 'range keys from in-memory index tree'  (duration: 270.075503ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:59.309522Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088700082589057,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T19:51:59.540915Z","caller":"traceutil/trace.go:171","msg":"trace[2098212466] linearizableReadLoop","detail":"{readStateIndex:1013; appliedIndex:1012; }","duration":"731.953904ms","start":"2026-02-25T19:51:58.808939Z","end":"2026-02-25T19:51:59.540893Z","steps":["trace[2098212466] 'read index received'  (duration: 731.747049ms)","trace[2098212466] 'applied index is now lower than readState.Index'  (duration: 205.975µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:51:59.541024Z","caller":"traceutil/trace.go:171","msg":"trace[1998862853] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"851.998367ms","start":"2026-02-25T19:51:58.689016Z","end":"2026-02-25T19:51:59.541014Z","steps":["trace[1998862853] 'process raft request'  (duration: 851.715451ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:59.541281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:58.688992Z","time spent":"852.058979ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:965 > 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-02-25T19:51:59.541326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.552549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T19:51:59.541394Z","caller":"traceutil/trace.go:171","msg":"trace[317799976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:974; }","duration":"616.640572ms","start":"2026-02-25T19:51:58.924719Z","end":"2026-02-25T19:51:59.54136Z","steps":["trace[317799976] 'agreement among raft nodes before linearized reading'  (duration: 616.478478ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:59.541437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:58.924701Z","time spent":"616.728034ms","remote":"127.0.0.1:46688","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-02-25T19:51:59.54164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.00413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-25T19:51:59.541687Z","caller":"traceutil/trace.go:171","msg":"trace[1833696303] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:974; }","duration":"397.071521ms","start":"2026-02-25T19:51:59.144605Z","end":"2026-02-25T19:51:59.541677Z","steps":["trace[1833696303] 'agreement among raft nodes before linearized reading'  (duration: 396.957038ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:59.541725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:59.144597Z","time spent":"397.121103ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T19:51:59.541725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.359728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-25T19:51:59.541771Z","caller":"traceutil/trace.go:171","msg":"trace[1406684891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:974; }","duration":"397.44837ms","start":"2026-02-25T19:51:59.144311Z","end":"2026-02-25T19:51:59.541759Z","steps":["trace[1406684891] 'agreement among raft nodes before linearized reading'  (duration: 397.313907ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:59.541817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:59.14429Z","time spent":"397.517292ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T19:51:59.541953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.096623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-02-25T19:51:59.541962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.02454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:51:59.541988Z","caller":"traceutil/trace.go:171","msg":"trace[1998975715] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:974; }","duration":"596.168565ms","start":"2026-02-25T19:51:58.945811Z","end":"2026-02-25T19:51:59.541979Z","steps":["trace[1998975715] 'agreement among raft nodes before linearized reading'  (duration: 596.079063ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:59.541997Z","caller":"traceutil/trace.go:171","msg":"trace[1906187131] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:974; }","duration":"733.096341ms","start":"2026-02-25T19:51:58.80889Z","end":"2026-02-25T19:51:59.541987Z","steps":["trace[1906187131] 'agreement among raft nodes before linearized reading'  (duration: 733.03689ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:59.542027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:58.808871Z","time spent":"733.148922ms","remote":"127.0.0.1:46706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T19:51:59.542366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.621787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:51:59.542395Z","caller":"traceutil/trace.go:171","msg":"trace[494348190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:974; }","duration":"125.686448ms","start":"2026-02-25T19:51:59.416701Z","end":"2026-02-25T19:51:59.542388Z","steps":["trace[494348190] 'agreement among raft nodes before linearized reading'  (duration: 125.640687ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:59.542026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:58.945795Z","time spent":"596.219667ms","remote":"127.0.0.1:46758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":68,"response size":29,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T19:51:59.542524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.232685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-25T19:51:59.542587Z","caller":"traceutil/trace.go:171","msg":"trace[314207811] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:974; }","duration":"397.313107ms","start":"2026-02-25T19:51:59.145259Z","end":"2026-02-25T19:51:59.542572Z","steps":["trace[314207811] 'agreement among raft nodes before linearized reading'  (duration: 397.165504ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:59.542633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:51:59.145248Z","time spent":"397.374969ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-25T19:51:59.750809Z","caller":"traceutil/trace.go:171","msg":"trace[1113946460] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"185.89987ms","start":"2026-02-25T19:51:59.564893Z","end":"2026-02-25T19:51:59.750792Z","steps":["trace[1113946460] 'process raft request'  (duration: 185.860529ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:59.751102Z","caller":"traceutil/trace.go:171","msg":"trace[753144164] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"189.047085ms","start":"2026-02-25T19:51:59.562033Z","end":"2026-02-25T19:51:59.75108Z","steps":["trace[753144164] 'process raft request'  (duration: 90.126563ms)","trace[753144164] 'compare'  (duration: 83.476035ms)","trace[753144164] 'store kv pair into bolt db' {req_type:put; key:/registry/leases/kube-system/plndr-cp-lock; req_size:415; } (duration: 15.011346ms)"],"step_count":3}
{"level":"info","ts":"2026-02-25T19:51:59.751215Z","caller":"traceutil/trace.go:171","msg":"trace[817806602] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"188.586534ms","start":"2026-02-25T19:51:59.562623Z","end":"2026-02-25T19:51:59.751209Z","steps":["trace[817806602] 'process raft request'  (duration: 188.099553ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:59.966735Z","caller":"traceutil/trace.go:171","msg":"trace[739288447] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"262.145403ms","start":"2026-02-25T19:51:59.704565Z","end":"2026-02-25T19:51:59.96671Z","steps":["trace[739288447] 'process raft request'  (duration: 261.783364ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:00.799719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.533029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:52:00.799799Z","caller":"traceutil/trace.go:171","msg":"trace[557799258] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:980; }","duration":"256.659381ms","start":"2026-02-25T19:52:00.543123Z","end":"2026-02-25T19:52:00.799783Z","steps":["trace[557799258] 'range keys from in-memory index tree'  (duration: 256.476537ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:00.79998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.740481ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088700082589072 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-nbtp9.18979549542e66eb\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-nbtp9.18979549542e66eb\" value_size:683 lease:4004716663227813017 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:52:00.800148Z","caller":"traceutil/trace.go:171","msg":"trace[573606225] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"225.476241ms","start":"2026-02-25T19:52:00.574663Z","end":"2026-02-25T19:52:00.800139Z","steps":["trace[573606225] 'process raft request'  (duration: 48.511774ms)","trace[573606225] 'compare'  (duration: 176.460295ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:52:00.912603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.515575ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088700082589073 > lease_revoke:<id:37939c9659c80d00>","response":"size:27"}
{"level":"info","ts":"2026-02-25T19:52:00.912874Z","caller":"traceutil/trace.go:171","msg":"trace[1472895952] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"109.027213ms","start":"2026-02-25T19:52:00.803828Z","end":"2026-02-25T19:52:00.912856Z","steps":["trace[1472895952] 'process raft request'  (duration: 108.882109ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:52:00.984272Z","caller":"traceutil/trace.go:171","msg":"trace[600193347] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"179.753954ms","start":"2026-02-25T19:52:00.804493Z","end":"2026-02-25T19:52:00.984247Z","steps":["trace[600193347] 'process raft request'  (duration: 179.5579ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:01.636906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.39272ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088700082589076 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.189795496cf8639b\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.189795496cf8639b\" value_size:692 lease:4004716663227813017 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:52:01.637126Z","caller":"traceutil/trace.go:171","msg":"trace[1338574950] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"487.747188ms","start":"2026-02-25T19:52:01.149361Z","end":"2026-02-25T19:52:01.637108Z","steps":["trace[1338574950] 'process raft request'  (duration: 487.673846ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:01.637235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:01.14933Z","time spent":"487.835439ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:931 > 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-02-25T19:52:01.637409Z","caller":"traceutil/trace.go:171","msg":"trace[1820888369] linearizableReadLoop","detail":"{readStateIndex:1024; appliedIndex:1023; }","duration":"647.443275ms","start":"2026-02-25T19:52:00.989749Z","end":"2026-02-25T19:52:01.637192Z","steps":["trace[1820888369] 'read index received'  (duration: 37.535413ms)","trace[1820888369] 'applied index is now lower than readState.Index'  (duration: 609.904932ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:52:01.637429Z","caller":"traceutil/trace.go:171","msg":"trace[459009285] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"647.68398ms","start":"2026-02-25T19:52:00.989529Z","end":"2026-02-25T19:52:01.637213Z","steps":["trace[459009285] 'process raft request'  (duration: 37.85085ms)","trace[459009285] 'compare'  (duration: 609.203545ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:52:01.637569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:00.98951Z","time spent":"647.986568ms","remote":"127.0.0.1:46492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.189795496cf8639b\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.189795496cf8639b\" value_size:692 lease:4004716663227813017 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:52:01.637706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.936997ms","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-02-25T19:52:01.637744Z","caller":"traceutil/trace.go:171","msg":"trace[1229422871] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:985; }","duration":"648.017469ms","start":"2026-02-25T19:52:00.989715Z","end":"2026-02-25T19:52:01.637733Z","steps":["trace[1229422871] 'agreement among raft nodes before linearized reading'  (duration: 647.805224ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:01.637778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:00.989709Z","time spent":"648.06137ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-25T19:52:03.006932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.140429ms","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-02-25T19:52:03.007098Z","caller":"traceutil/trace.go:171","msg":"trace[886863272] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:985; }","duration":"904.315823ms","start":"2026-02-25T19:52:02.102756Z","end":"2026-02-25T19:52:03.007072Z","steps":["trace[886863272] 'range keys from in-memory index tree'  (duration: 904.104777ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:03.007157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.810574ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088700082589080 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:983 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:52:03.007274Z","caller":"traceutil/trace.go:171","msg":"trace[714899557] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"1.365296843s","start":"2026-02-25T19:52:01.641954Z","end":"2026-02-25T19:52:03.007251Z","steps":["trace[714899557] 'process raft request'  (duration: 587.277694ms)","trace[714899557] 'compare'  (duration: 777.693412ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:52:03.007356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:01.641939Z","time spent":"1.365376415s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:983 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-02-25T19:52:03.231093Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.001857282s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T19:52:03.412698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.388483ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088700082589081 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:974 > 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-02-25T19:52:03.412888Z","caller":"traceutil/trace.go:171","msg":"trace[798700274] linearizableReadLoop","detail":"{readStateIndex:1028; appliedIndex:1025; }","duration":"1.657937302s","start":"2026-02-25T19:52:01.754934Z","end":"2026-02-25T19:52:03.412871Z","steps":["trace[798700274] 'read index received'  (duration: 474.312218ms)","trace[798700274] 'applied index is now lower than readState.Index'  (duration: 1.183624104s)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:52:03.412975Z","caller":"traceutil/trace.go:171","msg":"trace[609073519] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"1.7705966s","start":"2026-02-25T19:52:01.64237Z","end":"2026-02-25T19:52:03.412967Z","steps":["trace[609073519] 'process raft request'  (duration: 1.770430056s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:03.413037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:01.642336Z","time spent":"1.770669252s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:975 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T19:52:03.413025Z","caller":"traceutil/trace.go:171","msg":"trace[431102174] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"1.770661402s","start":"2026-02-25T19:52:01.642329Z","end":"2026-02-25T19:52:03.41299Z","steps":["trace[431102174] 'process raft request'  (duration: 1.588942091s)","trace[431102174] 'compare'  (duration: 180.83742ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:52:03.413224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:01.642313Z","time spent":"1.770804736s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:974 > 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-02-25T19:52:03.413299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.65740375s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-25T19:52:03.413412Z","caller":"traceutil/trace.go:171","msg":"trace[945062656] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:988; }","duration":"1.657539582s","start":"2026-02-25T19:52:01.755845Z","end":"2026-02-25T19:52:03.413385Z","steps":["trace[945062656] 'agreement among raft nodes before linearized reading'  (duration: 1.657277696s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:03.413467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.658532416s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-02-25T19:52:03.413472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000448268s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:52:03.413504Z","caller":"traceutil/trace.go:171","msg":"trace[457571267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:988; }","duration":"1.658598528s","start":"2026-02-25T19:52:01.754895Z","end":"2026-02-25T19:52:03.413493Z","steps":["trace[457571267] 'agreement among raft nodes before linearized reading'  (duration: 1.658486655s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:52:03.413523Z","caller":"traceutil/trace.go:171","msg":"trace[1505378036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:988; }","duration":"1.00053061s","start":"2026-02-25T19:52:02.412979Z","end":"2026-02-25T19:52:03.41351Z","steps":["trace[1505378036] 'agreement among raft nodes before linearized reading'  (duration: 1.000451488s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:03.413538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:01.754876Z","time spent":"1.658656579s","remote":"127.0.0.1:46688","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-02-25T19:52:03.41356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:02.412959Z","time spent":"1.000595112s","remote":"127.0.0.1:46438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:52:03.413597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.653624279s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"warn","ts":"2026-02-25T19:52:03.413476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:01.755835Z","time spent":"1.657627504s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-25T19:52:03.413649Z","caller":"traceutil/trace.go:171","msg":"trace[416403982] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:988; }","duration":"1.65367242s","start":"2026-02-25T19:52:01.759963Z","end":"2026-02-25T19:52:03.413636Z","steps":["trace[416403982] 'agreement among raft nodes before linearized reading'  (duration: 1.653545327s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:03.413358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.231547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T19:52:03.413693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:01.759925Z","time spent":"1.653758842s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-25T19:52:03.413723Z","caller":"traceutil/trace.go:171","msg":"trace[201541455] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:988; }","duration":"215.641447ms","start":"2026-02-25T19:52:03.198069Z","end":"2026-02-25T19:52:03.41371Z","steps":["trace[201541455] 'agreement among raft nodes before linearized reading'  (duration: 215.254788ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:03.622705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.299979ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088700082589086 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:976 > 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-02-25T19:52:03.622901Z","caller":"traceutil/trace.go:171","msg":"trace[1509928900] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1028; }","duration":"201.135262ms","start":"2026-02-25T19:52:03.42175Z","end":"2026-02-25T19:52:03.622885Z","steps":["trace[1509928900] 'read index received'  (duration: 99.592418ms)","trace[1509928900] 'applied index is now lower than readState.Index'  (duration: 101.541804ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:52:03.622982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.228755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:52:03.623059Z","caller":"traceutil/trace.go:171","msg":"trace[801625403] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"203.287663ms","start":"2026-02-25T19:52:03.419724Z","end":"2026-02-25T19:52:03.623012Z","steps":["trace[801625403] 'process raft request'  (duration: 203.070268ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:52:03.623082Z","caller":"traceutil/trace.go:171","msg":"trace[705992230] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"202.32841ms","start":"2026-02-25T19:52:03.420722Z","end":"2026-02-25T19:52:03.62305Z","steps":["trace[705992230] 'process raft request'  (duration: 202.124316ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:52:03.623016Z","caller":"traceutil/trace.go:171","msg":"trace[1762969338] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:991; }","duration":"201.274555ms","start":"2026-02-25T19:52:03.421731Z","end":"2026-02-25T19:52:03.623005Z","steps":["trace[1762969338] 'agreement among raft nodes before linearized reading'  (duration: 201.207204ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:52:03.62364Z","caller":"traceutil/trace.go:171","msg":"trace[2003545742] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"203.778626ms","start":"2026-02-25T19:52:03.419363Z","end":"2026-02-25T19:52:03.623142Z","steps":["trace[2003545742] 'process raft request'  (duration: 101.961665ms)","trace[2003545742] 'compare'  (duration: 101.183736ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:52:06.749769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.125101ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13228088700082589095 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:988 > 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-02-25T19:52:06.7499Z","caller":"traceutil/trace.go:171","msg":"trace[1667081131] linearizableReadLoop","detail":"{readStateIndex:1033; appliedIndex:1032; }","duration":"1.230904438s","start":"2026-02-25T19:52:05.518977Z","end":"2026-02-25T19:52:06.749881Z","steps":["trace[1667081131] 'read index received'  (duration: 341.595382ms)","trace[1667081131] 'applied index is now lower than readState.Index'  (duration: 889.307536ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:52:06.750048Z","caller":"traceutil/trace.go:171","msg":"trace[308648736] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"1.327987836s","start":"2026-02-25T19:52:05.42199Z","end":"2026-02-25T19:52:06.749978Z","steps":["trace[308648736] 'process raft request'  (duration: 438.574108ms)","trace[308648736] 'compare'  (duration: 888.965718ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:52:06.750134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:05.421972Z","time spent":"1.32811447s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:988 > 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-02-25T19:52:06.750169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.687876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T19:52:06.750219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.121156169s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-25T19:52:06.750237Z","caller":"traceutil/trace.go:171","msg":"trace[1789419809] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:993; }","duration":"336.797339ms","start":"2026-02-25T19:52:06.413423Z","end":"2026-02-25T19:52:06.75022Z","steps":["trace[1789419809] 'agreement among raft nodes before linearized reading'  (duration: 336.655586ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:06.750281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:06.413403Z","time spent":"336.87149ms","remote":"127.0.0.1:46438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T19:52:06.750276Z","caller":"traceutil/trace.go:171","msg":"trace[1898971135] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:993; }","duration":"1.121259071s","start":"2026-02-25T19:52:05.629004Z","end":"2026-02-25T19:52:06.750263Z","steps":["trace[1898971135] 'agreement among raft nodes before linearized reading'  (duration: 1.121071587s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:06.750316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:05.628982Z","time spent":"1.121328233s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-25T19:52:06.750336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.120751309s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-02-25T19:52:06.750435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.121389704s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-25T19:52:06.750435Z","caller":"traceutil/trace.go:171","msg":"trace[829415734] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:993; }","duration":"1.120876453s","start":"2026-02-25T19:52:05.629536Z","end":"2026-02-25T19:52:06.750412Z","steps":["trace[829415734] 'agreement among raft nodes before linearized reading'  (duration: 1.120604336s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:52:06.750458Z","caller":"traceutil/trace.go:171","msg":"trace[926399613] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:993; }","duration":"1.121435406s","start":"2026-02-25T19:52:05.629016Z","end":"2026-02-25T19:52:06.750451Z","steps":["trace[926399613] 'agreement among raft nodes before linearized reading'  (duration: 1.121376834s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:06.750476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:05.629003Z","time spent":"1.121467876s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T19:52:06.750492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:05.629527Z","time spent":"1.120951824s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T19:52:06.750557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.231556864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.209\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T19:52:06.750645Z","caller":"traceutil/trace.go:171","msg":"trace[1864276088] range","detail":"{range_begin:/registry/masterleases/162.253.55.209; range_end:; response_count:1; response_revision:993; }","duration":"1.231706508s","start":"2026-02-25T19:52:05.518918Z","end":"2026-02-25T19:52:06.750625Z","steps":["trace[1864276088] 'agreement among raft nodes before linearized reading'  (duration: 1.231243287s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:06.751111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:05.518898Z","time spent":"1.232094286s","remote":"127.0.0.1:46456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.209\" "}
{"level":"info","ts":"2026-02-25T19:52:07.372566Z","caller":"traceutil/trace.go:171","msg":"trace[542778886] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"617.621364ms","start":"2026-02-25T19:52:06.754926Z","end":"2026-02-25T19:52:07.372548Z","steps":["trace[542778886] 'process raft request'  (duration: 617.565973ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:52:07.372618Z","caller":"traceutil/trace.go:171","msg":"trace[1692243815] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"618.70348ms","start":"2026-02-25T19:52:06.753884Z","end":"2026-02-25T19:52:07.372587Z","steps":["trace[1692243815] 'process raft request'  (duration: 618.460394ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:07.372677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:06.754912Z","time spent":"617.703817ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:991 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T19:52:07.372785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:06.753865Z","time spent":"618.825153ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:989 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-25T19:52:07.372797Z","caller":"traceutil/trace.go:171","msg":"trace[1285373481] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"617.799229ms","start":"2026-02-25T19:52:06.754974Z","end":"2026-02-25T19:52:07.372774Z","steps":["trace[1285373481] 'process raft request'  (duration: 617.549303ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:07.372915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:06.754953Z","time spent":"617.897791ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:990 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-25T19:52:07.432977Z","caller":"traceutil/trace.go:171","msg":"trace[1599949564] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"610.489276ms","start":"2026-02-25T19:52:06.822469Z","end":"2026-02-25T19:52:07.432959Z","steps":["trace[1599949564] 'process raft request'  (duration: 610.386913ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:07.433101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:06.822445Z","time spent":"610.590028ms","remote":"127.0.0.1:46456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.209\" mod_revision:955 > success:<request_put:<key:\"/registry/masterleases/162.253.55.209\" value_size:67 lease:4004716663227813291 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.209\" > >"}
{"level":"warn","ts":"2026-02-25T19:52:09.91384Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088700082589129,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T19:52:10.051791Z","caller":"traceutil/trace.go:171","msg":"trace[1118311537] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"670.450881ms","start":"2026-02-25T19:52:09.381239Z","end":"2026-02-25T19:52:10.051689Z","steps":["trace[1118311537] 'process raft request'  (duration: 670.313058ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:10.05194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:09.381219Z","time spent":"670.648237ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:996 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-25T19:52:10.647411Z","caller":"traceutil/trace.go:171","msg":"trace[212926232] linearizableReadLoop","detail":"{readStateIndex:1052; appliedIndex:1049; }","duration":"1.23439938s","start":"2026-02-25T19:52:09.412995Z","end":"2026-02-25T19:52:10.647395Z","steps":["trace[212926232] 'read index received'  (duration: 638.659046ms)","trace[212926232] 'applied index is now lower than readState.Index'  (duration: 595.739664ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:52:10.647452Z","caller":"traceutil/trace.go:171","msg":"trace[1365742506] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"1.265525101s","start":"2026-02-25T19:52:09.381896Z","end":"2026-02-25T19:52:10.647421Z","steps":["trace[1365742506] 'process raft request'  (duration: 1.265376918s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:52:10.647503Z","caller":"traceutil/trace.go:171","msg":"trace[438489759] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"1.265360856s","start":"2026-02-25T19:52:09.382121Z","end":"2026-02-25T19:52:10.647481Z","steps":["trace[438489759] 'process raft request'  (duration: 1.265248104s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:10.647535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.234531603s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:52:10.647558Z","caller":"traceutil/trace.go:171","msg":"trace[1097196988] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1011; }","duration":"1.234612035s","start":"2026-02-25T19:52:09.412938Z","end":"2026-02-25T19:52:10.64755Z","steps":["trace[1097196988] 'agreement among raft nodes before linearized reading'  (duration: 1.234545224s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:10.647581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:09.412917Z","time spent":"1.234659487s","remote":"127.0.0.1:46438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:52:10.64759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:09.381883Z","time spent":"1.265633063s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:995 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T19:52:10.6476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:09.382093Z","time spent":"1.265457919s","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:994 > 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-02-25T19:52:10.647885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.139995435s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T19:52:10.647959Z","caller":"traceutil/trace.go:171","msg":"trace[616214103] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1011; }","duration":"1.140115078s","start":"2026-02-25T19:52:09.507827Z","end":"2026-02-25T19:52:10.647942Z","steps":["trace[616214103] 'agreement among raft nodes before linearized reading'  (duration: 1.139875703s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:10.648089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:09.507809Z","time spent":"1.140262881s","remote":"127.0.0.1:46688","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-02-25T19:52:10.770473Z","caller":"traceutil/trace.go:171","msg":"trace[72189308] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"118.843815ms","start":"2026-02-25T19:52:10.651605Z","end":"2026-02-25T19:52:10.770449Z","steps":["trace[72189308] 'process raft request'  (duration: 108.95666ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:52:10.770969Z","caller":"traceutil/trace.go:171","msg":"trace[1029637411] linearizableReadLoop","detail":"{readStateIndex:1053; appliedIndex:1052; }","duration":"115.421484ms","start":"2026-02-25T19:52:10.65553Z","end":"2026-02-25T19:52:10.770952Z","steps":["trace[1029637411] 'read index received'  (duration: 105.041787ms)","trace[1029637411] 'applied index is now lower than readState.Index'  (duration: 10.377447ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:52:10.780633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.076814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:52:10.780886Z","caller":"traceutil/trace.go:171","msg":"trace[1100806872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1012; }","duration":"125.262399ms","start":"2026-02-25T19:52:10.655503Z","end":"2026-02-25T19:52:10.780766Z","steps":["trace[1100806872] 'agreement among raft nodes before linearized reading'  (duration: 115.510076ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:12.286121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.64214ms","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-02-25T19:52:12.286227Z","caller":"traceutil/trace.go:171","msg":"trace[317314419] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1016; }","duration":"183.768643ms","start":"2026-02-25T19:52:12.102443Z","end":"2026-02-25T19:52:12.286212Z","steps":["trace[317314419] 'range keys from in-memory index tree'  (duration: 183.624839ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:12.2863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.182399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-02-25T19:52:12.286303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.783412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:52:12.28638Z","caller":"traceutil/trace.go:171","msg":"trace[897862808] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1016; }","duration":"230.294542ms","start":"2026-02-25T19:52:12.056072Z","end":"2026-02-25T19:52:12.286366Z","steps":["trace[897862808] 'range keys from in-memory index tree'  (duration: 230.002245ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:52:12.28641Z","caller":"traceutil/trace.go:171","msg":"trace[1060955017] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1016; }","duration":"301.909135ms","start":"2026-02-25T19:52:11.984465Z","end":"2026-02-25T19:52:12.286374Z","steps":["trace[1060955017] 'range keys from in-memory index tree'  (duration: 301.707151ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:12.286449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:11.984447Z","time spent":"301.993977ms","remote":"127.0.0.1:46688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}