{"level":"warn","ts":"2026-02-25T06:06:44.733996Z","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-25T06:06:44.734082Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.204: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.204:2380","--initial-cluster=instance=https://162.253.55.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.204: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-25T06:06:44.734149Z","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-25T06:06:44.734239Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.204:2380"]}
{"level":"info","ts":"2026-02-25T06:06:44.734305Z","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-25T06:06:44.73496Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"]}
{"level":"info","ts":"2026-02-25T06:06:44.735061Z","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.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.204: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-25T06:06:45.179915Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"393.602223ms"}
{"level":"warn","ts":"2026-02-25T06:06:46.883068Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.555176485s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T06:06:47.502133Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a11c20306510c1f7","cluster-id":"97da89d0cbebd2b5"}
{"level":"info","ts":"2026-02-25T06:06:47.502272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T06:06:47.502311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 0"}
{"level":"info","ts":"2026-02-25T06:06:47.502358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a11c20306510c1f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T06:06:47.50239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 1"}
{"level":"info","ts":"2026-02-25T06:06:47.502476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"}
{"level":"warn","ts":"2026-02-25T06:06:47.530963Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T06:06:47.538568Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T06:06:47.542881Z","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-25T06:06:47.546081Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a11c20306510c1f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T06:06:47.546393Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a11c20306510c1f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T06:06:47.54645Z","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-25T06:06:47.546577Z","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-25T06:06:47.546619Z","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-25T06:06:47.549153Z","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-25T06:06:47.549254Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.204:2380"}
{"level":"info","ts":"2026-02-25T06:06:47.549296Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.204:2380"}
{"level":"info","ts":"2026-02-25T06:06:47.549428Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a11c20306510c1f7","initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T06:06:47.549465Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T06:06:47.550149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"}
{"level":"info","ts":"2026-02-25T06:06:47.550491Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","added-peer-id":"a11c20306510c1f7","added-peer-peer-urls":["https://162.253.55.204:2380"]}
{"level":"info","ts":"2026-02-25T06:06:47.804855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T06:06:47.80504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T06:06:47.805088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgPreVoteResp from a11c20306510c1f7 at term 1"}
{"level":"info","ts":"2026-02-25T06:06:47.805112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became candidate at term 2"}
{"level":"info","ts":"2026-02-25T06:06:47.805125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgVoteResp from a11c20306510c1f7 at term 2"}
{"level":"info","ts":"2026-02-25T06:06:47.805179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became leader at term 2"}
{"level":"info","ts":"2026-02-25T06:06:47.805206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a11c20306510c1f7 elected leader a11c20306510c1f7 at term 2"}
{"level":"info","ts":"2026-02-25T06:06:47.806212Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a11c20306510c1f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.204:2379]}","request-path":"/0/members/a11c20306510c1f7/attributes","cluster-id":"97da89d0cbebd2b5","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T06:06:47.806302Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T06:06:47.806433Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T06:06:47.806543Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T06:06:47.806852Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T06:06:47.806287Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T06:06:47.808147Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.204:2379"}
{"level":"info","ts":"2026-02-25T06:06:47.808792Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T06:06:47.809075Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T06:06:47.809132Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T06:06:47.810211Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-02-25T06:07:15.729188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.291501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:07:15.729264Z","caller":"traceutil/trace.go:171","msg":"trace[526341976] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:468; }","duration":"114.417615ms","start":"2026-02-25T06:07:15.61483Z","end":"2026-02-25T06:07:15.729248Z","steps":["trace[526341976] 'range keys from in-memory index tree'  (duration: 114.221369ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:16.550536Z","caller":"traceutil/trace.go:171","msg":"trace[2127882678] linearizableReadLoop","detail":"{readStateIndex:490; appliedIndex:488; }","duration":"354.172567ms","start":"2026-02-25T06:07:16.196341Z","end":"2026-02-25T06:07:16.550514Z","steps":["trace[2127882678] 'read index received'  (duration: 277.418551ms)","trace[2127882678] 'applied index is now lower than readState.Index'  (duration: 76.752926ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:07:16.550595Z","caller":"traceutil/trace.go:171","msg":"trace[1121063885] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"646.901461ms","start":"2026-02-25T06:07:15.903627Z","end":"2026-02-25T06:07:16.550529Z","steps":["trace[1121063885] 'process raft request'  (duration: 570.197206ms)","trace[1121063885] 'compare'  (duration: 76.492829ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:07:16.550705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.351993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T06:07:16.55078Z","caller":"traceutil/trace.go:171","msg":"trace[965128170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:475; }","duration":"354.482566ms","start":"2026-02-25T06:07:16.196266Z","end":"2026-02-25T06:07:16.550749Z","steps":["trace[965128170] 'agreement among raft nodes before linearized reading'  (duration: 354.332852ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:16.550604Z","caller":"traceutil/trace.go:171","msg":"trace[128200888] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"646.924012ms","start":"2026-02-25T06:07:15.903632Z","end":"2026-02-25T06:07:16.550556Z","steps":["trace[128200888] 'process raft request'  (duration: 646.812778ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:16.550814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.170384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-02-25T06:07:16.550907Z","caller":"traceutil/trace.go:171","msg":"trace[1180310564] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:475; }","duration":"277.309238ms","start":"2026-02-25T06:07:16.273577Z","end":"2026-02-25T06:07:16.550886Z","steps":["trace[1180310564] 'agreement among raft nodes before linearized reading'  (duration: 277.120282ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:16.550818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:16.196239Z","time spent":"354.570219ms","remote":"127.0.0.1:36188","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-25T06:07:16.552718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:15.903613Z","time spent":"647.111096ms","remote":"127.0.0.1:36264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2364,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/clusterroles/cilium-operator\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/cilium-operator\" value_size:2318 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T06:07:16.553156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:15.903618Z","time spent":"647.214459ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:465 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-25T06:07:16.790206Z","caller":"traceutil/trace.go:171","msg":"trace[1326047830] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"149.455711ms","start":"2026-02-25T06:07:16.640726Z","end":"2026-02-25T06:07:16.790182Z","steps":["trace[1326047830] 'process raft request'  (duration: 117.093359ms)","trace[1326047830] 'compare'  (duration: 32.180197ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:07:18.80722Z","caller":"traceutil/trace.go:171","msg":"trace[1159272582] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:524; }","duration":"153.73948ms","start":"2026-02-25T06:07:18.653462Z","end":"2026-02-25T06:07:18.807201Z","steps":["trace[1159272582] 'read index received'  (duration: 150.538942ms)","trace[1159272582] 'applied index is now lower than readState.Index'  (duration: 3.199758ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:07:18.807346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.856163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4021"}
{"level":"info","ts":"2026-02-25T06:07:18.807365Z","caller":"traceutil/trace.go:171","msg":"trace[498864100] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:509; }","duration":"153.937175ms","start":"2026-02-25T06:07:18.653422Z","end":"2026-02-25T06:07:18.807359Z","steps":["trace[498864100] 'agreement among raft nodes before linearized reading'  (duration: 153.864533ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:18.807476Z","caller":"traceutil/trace.go:171","msg":"trace[393498489] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"179.939513ms","start":"2026-02-25T06:07:18.627514Z","end":"2026-02-25T06:07:18.807453Z","steps":["trace[393498489] 'process raft request'  (duration: 176.537259ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:20.497244Z","caller":"traceutil/trace.go:171","msg":"trace[914030683] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"154.895782ms","start":"2026-02-25T06:07:20.34232Z","end":"2026-02-25T06:07:20.497216Z","steps":["trace[914030683] 'process raft request'  (duration: 154.744808ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:21.275256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.649433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:07:21.275548Z","caller":"traceutil/trace.go:171","msg":"trace[2136521661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"659.990112ms","start":"2026-02-25T06:07:20.61554Z","end":"2026-02-25T06:07:21.27553Z","steps":["trace[2136521661] 'range keys from in-memory index tree'  (duration: 659.58686ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:21.275557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.013145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-02-25T06:07:21.275596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:20.615524Z","time spent":"660.063644ms","remote":"127.0.0.1:56054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T06:07:21.27564Z","caller":"traceutil/trace.go:171","msg":"trace[1485018134] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:512; }","duration":"684.137318ms","start":"2026-02-25T06:07:20.591477Z","end":"2026-02-25T06:07:21.275614Z","steps":["trace[1485018134] 'range keys from in-memory index tree'  (duration: 683.84645ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:21.275414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.382147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-02-25T06:07:21.275708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:20.59145Z","time spent":"684.23017ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T06:07:21.275479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.091569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-25T06:07:21.275754Z","caller":"traceutil/trace.go:171","msg":"trace[161764186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:512; }","duration":"464.733647ms","start":"2026-02-25T06:07:20.810983Z","end":"2026-02-25T06:07:21.275717Z","steps":["trace[161764186] 'range keys from in-memory index tree'  (duration: 464.254794ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:21.275813Z","caller":"traceutil/trace.go:171","msg":"trace[990449760] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:512; }","duration":"708.448999ms","start":"2026-02-25T06:07:20.567347Z","end":"2026-02-25T06:07:21.275796Z","steps":["trace[990449760] 'range keys from in-memory index tree'  (duration: 707.940625ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:21.275852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:20.810968Z","time spent":"464.85127ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T06:07:21.275851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:20.56733Z","time spent":"708.51295ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-25T06:07:21.877511Z","caller":"traceutil/trace.go:171","msg":"trace[1866979397] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"598.437595ms","start":"2026-02-25T06:07:21.279051Z","end":"2026-02-25T06:07:21.877489Z","steps":["trace[1866979397] 'process raft request'  (duration: 598.27795ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:21.877759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:21.279038Z","time spent":"598.608469ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:508 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-25T06:07:21.997272Z","caller":"traceutil/trace.go:171","msg":"trace[198397479] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:528; }","duration":"235.65855ms","start":"2026-02-25T06:07:21.761592Z","end":"2026-02-25T06:07:21.997251Z","steps":["trace[198397479] 'read index received'  (duration: 115.715972ms)","trace[198397479] 'applied index is now lower than readState.Index'  (duration: 119.941408ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:07:21.997593Z","caller":"traceutil/trace.go:171","msg":"trace[2118489857] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"718.490175ms","start":"2026-02-25T06:07:21.279074Z","end":"2026-02-25T06:07:21.997564Z","steps":["trace[2118489857] 'process raft request'  (duration: 717.968731ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:21.997739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:21.279049Z","time spent":"718.592828ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:507 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-25T06:07:21.997943Z","caller":"traceutil/trace.go:171","msg":"trace[1749702883] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"716.963703ms","start":"2026-02-25T06:07:21.280969Z","end":"2026-02-25T06:07:21.997933Z","steps":["trace[1749702883] 'process raft request'  (duration: 716.207233ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:21.998001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:21.280959Z","time spent":"717.009134ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:509 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-25T06:07:21.998205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.606256ms","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-25T06:07:21.998252Z","caller":"traceutil/trace.go:171","msg":"trace[108284779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"236.681308ms","start":"2026-02-25T06:07:21.761553Z","end":"2026-02-25T06:07:21.998234Z","steps":["trace[108284779] 'agreement among raft nodes before linearized reading'  (duration: 236.551374ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:21.998409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.795655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T06:07:21.998456Z","caller":"traceutil/trace.go:171","msg":"trace[1217416383] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:515; }","duration":"205.863537ms","start":"2026-02-25T06:07:21.792582Z","end":"2026-02-25T06:07:21.998446Z","steps":["trace[1217416383] 'agreement among raft nodes before linearized reading'  (duration: 205.789115ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:30.117601Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812125490434978,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T06:07:30.618604Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812125490434978,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T06:07:30.691522Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.223813441s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T06:07:30.692186Z","caller":"traceutil/trace.go:171","msg":"trace[697742835] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"1.224595693s","start":"2026-02-25T06:07:29.467558Z","end":"2026-02-25T06:07:30.692153Z","steps":["trace[697742835] 'process raft request'  (duration: 1.224276544s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:30.692435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:29.467528Z","time spent":"1.224791128s","remote":"127.0.0.1:36106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-t4bfz\" mod_revision:500 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-t4bfz\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-t4bfz\" > >"}
{"level":"info","ts":"2026-02-25T06:07:30.697125Z","caller":"traceutil/trace.go:171","msg":"trace[1598976631] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:551; }","duration":"1.080396906s","start":"2026-02-25T06:07:29.616704Z","end":"2026-02-25T06:07:30.697101Z","steps":["trace[1598976631] 'read index received'  (duration: 1.0751165s)","trace[1598976631] 'applied index is now lower than readState.Index'  (duration: 5.279366ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:07:30.69734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080610982s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:07:30.697419Z","caller":"traceutil/trace.go:171","msg":"trace[1205361683] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:535; }","duration":"1.080731035s","start":"2026-02-25T06:07:29.616669Z","end":"2026-02-25T06:07:30.6974Z","steps":["trace[1205361683] 'agreement among raft nodes before linearized reading'  (duration: 1.080600391s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:30.697464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:29.616648Z","time spent":"1.080808087s","remote":"127.0.0.1:56058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T06:07:30.69749Z","caller":"traceutil/trace.go:171","msg":"trace[512479530] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"122.101347ms","start":"2026-02-25T06:07:30.575374Z","end":"2026-02-25T06:07:30.697475Z","steps":["trace[512479530] 'process raft request'  (duration: 121.600403ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:30.697493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.506077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-02-25T06:07:30.697542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.077608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T06:07:30.697563Z","caller":"traceutil/trace.go:171","msg":"trace[105527765] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:535; }","duration":"734.60397ms","start":"2026-02-25T06:07:29.962944Z","end":"2026-02-25T06:07:30.697547Z","steps":["trace[105527765] 'agreement among raft nodes before linearized reading'  (duration: 734.420525ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:30.697591Z","caller":"traceutil/trace.go:171","msg":"trace[757955975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:535; }","duration":"609.16745ms","start":"2026-02-25T06:07:30.088413Z","end":"2026-02-25T06:07:30.697581Z","steps":["trace[757955975] 'agreement among raft nodes before linearized reading'  (duration: 608.975855ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:30.697601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:29.96293Z","time spent":"734.662711ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T06:07:30.697627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:30.088395Z","time spent":"609.227092ms","remote":"127.0.0.1:36188","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-25T06:07:30.697749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.752235ms","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-25T06:07:30.697787Z","caller":"traceutil/trace.go:171","msg":"trace[2136638232] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:535; }","duration":"610.828957ms","start":"2026-02-25T06:07:30.086948Z","end":"2026-02-25T06:07:30.697777Z","steps":["trace[2136638232] 'agreement among raft nodes before linearized reading'  (duration: 610.734824ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:30.697821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:30.086926Z","time spent":"610.884207ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T06:07:30.697844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.565109ms","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-25T06:07:30.697882Z","caller":"traceutil/trace.go:171","msg":"trace[712809400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:535; }","duration":"573.637651ms","start":"2026-02-25T06:07:30.124234Z","end":"2026-02-25T06:07:30.697872Z","steps":["trace[712809400] 'agreement among raft nodes before linearized reading'  (duration: 573.487617ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:30.697916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:30.124217Z","time spent":"573.689482ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-25T06:07:30.883662Z","caller":"traceutil/trace.go:171","msg":"trace[779974212] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"179.530241ms","start":"2026-02-25T06:07:30.704107Z","end":"2026-02-25T06:07:30.883637Z","steps":["trace[779974212] 'process raft request'  (duration: 179.453649ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:30.883697Z","caller":"traceutil/trace.go:171","msg":"trace[553748390] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"179.639694ms","start":"2026-02-25T06:07:30.704024Z","end":"2026-02-25T06:07:30.883664Z","steps":["trace[553748390] 'process raft request'  (duration: 179.403248ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:30.883853Z","caller":"traceutil/trace.go:171","msg":"trace[963063943] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:553; }","duration":"174.431911ms","start":"2026-02-25T06:07:30.709402Z","end":"2026-02-25T06:07:30.883834Z","steps":["trace[963063943] 'read index received'  (duration: 7.25756ms)","trace[963063943] 'applied index is now lower than readState.Index'  (duration: 167.173391ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:07:30.883916Z","caller":"traceutil/trace.go:171","msg":"trace[757126957] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"179.196672ms","start":"2026-02-25T06:07:30.704708Z","end":"2026-02-25T06:07:30.883905Z","steps":["trace[757126957] 'process raft request'  (duration: 178.896304ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:30.883948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.528123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:07:30.883972Z","caller":"traceutil/trace.go:171","msg":"trace[473341412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:539; }","duration":"174.581804ms","start":"2026-02-25T06:07:30.709382Z","end":"2026-02-25T06:07:30.883964Z","steps":["trace[473341412] 'agreement among raft nodes before linearized reading'  (duration: 174.524903ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:32.638001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.382897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T06:07:32.638049Z","caller":"traceutil/trace.go:171","msg":"trace[1330593951] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:539; }","duration":"844.47551ms","start":"2026-02-25T06:07:31.793564Z","end":"2026-02-25T06:07:32.638039Z","steps":["trace[1330593951] 'range keys from in-memory index tree'  (duration: 844.275534ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:32.638069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:31.793545Z","time spent":"844.519071ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.204\" "}
{"level":"info","ts":"2026-02-25T06:07:33.62752Z","caller":"traceutil/trace.go:171","msg":"trace[932136259] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"150.967143ms","start":"2026-02-25T06:07:33.476532Z","end":"2026-02-25T06:07:33.627499Z","steps":["trace[932136259] 'process raft request'  (duration: 150.756347ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:35.083565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.782452ms","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-25T06:07:35.083647Z","caller":"traceutil/trace.go:171","msg":"trace[428178584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:555; }","duration":"353.909625ms","start":"2026-02-25T06:07:34.729719Z","end":"2026-02-25T06:07:35.083628Z","steps":["trace[428178584] 'range keys from in-memory index tree'  (duration: 353.588266ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:35.083688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:34.729698Z","time spent":"353.980037ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T06:07:35.083735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.350905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-25T06:07:35.083815Z","caller":"traceutil/trace.go:171","msg":"trace[935927250] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:555; }","duration":"185.435868ms","start":"2026-02-25T06:07:34.898356Z","end":"2026-02-25T06:07:35.083792Z","steps":["trace[935927250] 'range keys from in-memory index tree'  (duration: 185.187952ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:35.084062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.552101ms","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-25T06:07:35.084101Z","caller":"traceutil/trace.go:171","msg":"trace[1436347899] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:555; }","duration":"185.629233ms","start":"2026-02-25T06:07:34.898459Z","end":"2026-02-25T06:07:35.084088Z","steps":["trace[1436347899] 'range keys from in-memory index tree'  (duration: 185.427837ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:35.084496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.17212ms","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-25T06:07:35.08456Z","caller":"traceutil/trace.go:171","msg":"trace[1015602266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:555; }","duration":"154.277463ms","start":"2026-02-25T06:07:34.930268Z","end":"2026-02-25T06:07:35.084545Z","steps":["trace[1015602266] 'range keys from in-memory index tree'  (duration: 153.969464ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:38.253868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.116907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"}
{"level":"warn","ts":"2026-02-25T06:07:38.253916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.79006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"}
{"level":"info","ts":"2026-02-25T06:07:38.253959Z","caller":"traceutil/trace.go:171","msg":"trace[44952601] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:609; }","duration":"329.24957ms","start":"2026-02-25T06:07:37.924688Z","end":"2026-02-25T06:07:38.253937Z","steps":["trace[44952601] 'range keys from in-memory index tree'  (duration: 328.903151ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:38.253996Z","caller":"traceutil/trace.go:171","msg":"trace[1837897243] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:609; }","duration":"528.944064ms","start":"2026-02-25T06:07:37.725031Z","end":"2026-02-25T06:07:38.253975Z","steps":["trace[1837897243] 'range keys from in-memory index tree'  (duration: 528.631186ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:38.254005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:37.924676Z","time spent":"329.317613ms","remote":"127.0.0.1:35962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9344,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "}
{"level":"warn","ts":"2026-02-25T06:07:38.254045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:37.725009Z","time spent":"529.023647ms","remote":"127.0.0.1:35962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4107,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "}
{"level":"info","ts":"2026-02-25T06:07:38.254788Z","caller":"traceutil/trace.go:171","msg":"trace[1321911641] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"126.469731ms","start":"2026-02-25T06:07:38.128307Z","end":"2026-02-25T06:07:38.254776Z","steps":["trace[1321911641] 'process raft request'  (duration: 126.362728ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:43.702295Z","caller":"traceutil/trace.go:171","msg":"trace[62949213] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"270.482199ms","start":"2026-02-25T06:07:43.431788Z","end":"2026-02-25T06:07:43.70227Z","steps":["trace[62949213] 'process raft request'  (duration: 270.279453ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:49.604549Z","caller":"traceutil/trace.go:171","msg":"trace[219343002] linearizableReadLoop","detail":"{readStateIndex:739; appliedIndex:738; }","duration":"355.352685ms","start":"2026-02-25T06:07:49.249171Z","end":"2026-02-25T06:07:49.604524Z","steps":["trace[219343002] 'read index received'  (duration: 355.159959ms)","trace[219343002] 'applied index is now lower than readState.Index'  (duration: 192.126µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:07:49.604682Z","caller":"traceutil/trace.go:171","msg":"trace[1159218011] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"373.379166ms","start":"2026-02-25T06:07:49.231266Z","end":"2026-02-25T06:07:49.604645Z","steps":["trace[1159218011] 'process raft request'  (duration: 373.090198ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:49.604806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.584802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-02-25T06:07:49.604849Z","caller":"traceutil/trace.go:171","msg":"trace[1061238123] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:715; }","duration":"355.702634ms","start":"2026-02-25T06:07:49.249136Z","end":"2026-02-25T06:07:49.604838Z","steps":["trace[1061238123] 'agreement among raft nodes before linearized reading'  (duration: 355.52619ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:49.604872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.586922ms","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-25T06:07:49.604898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.802442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T06:07:49.604974Z","caller":"traceutil/trace.go:171","msg":"trace[1030607989] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:715; }","duration":"355.706915ms","start":"2026-02-25T06:07:49.24925Z","end":"2026-02-25T06:07:49.604957Z","steps":["trace[1030607989] 'agreement among raft nodes before linearized reading'  (duration: 355.483059ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:49.604994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.23254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T06:07:49.604976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.604619ms","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-25T06:07:49.605028Z","caller":"traceutil/trace.go:171","msg":"trace[2084735157] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:715; }","duration":"191.299891ms","start":"2026-02-25T06:07:49.413719Z","end":"2026-02-25T06:07:49.605018Z","steps":["trace[2084735157] 'agreement among raft nodes before linearized reading'  (duration: 191.227039ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:49.605029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:49.249244Z","time spent":"355.772816ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-25T06:07:49.60507Z","caller":"traceutil/trace.go:171","msg":"trace[51194696] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:715; }","duration":"307.729123ms","start":"2026-02-25T06:07:49.297319Z","end":"2026-02-25T06:07:49.605048Z","steps":["trace[51194696] 'agreement among raft nodes before linearized reading'  (duration: 307.471626ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:49.604981Z","caller":"traceutil/trace.go:171","msg":"trace[226329215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:715; }","duration":"353.906955ms","start":"2026-02-25T06:07:49.25106Z","end":"2026-02-25T06:07:49.604967Z","steps":["trace[226329215] 'agreement among raft nodes before linearized reading'  (duration: 353.73983ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:49.605123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:49.297309Z","time spent":"307.804995ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-25T06:07:49.605144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:49.25105Z","time spent":"354.072659ms","remote":"127.0.0.1:36188","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-25T06:07:49.604882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:49.231242Z","time spent":"373.55805ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:710 > 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-25T06:07:49.604886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:49.249123Z","time spent":"355.754277ms","remote":"127.0.0.1:36188","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-25T06:07:49.763398Z","caller":"traceutil/trace.go:171","msg":"trace[155929781] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"153.07663ms","start":"2026-02-25T06:07:49.610298Z","end":"2026-02-25T06:07:49.763374Z","steps":["trace[155929781] 'process raft request'  (duration: 147.6643ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:49.803788Z","caller":"traceutil/trace.go:171","msg":"trace[1854736510] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"193.44728ms","start":"2026-02-25T06:07:49.610305Z","end":"2026-02-25T06:07:49.803753Z","steps":["trace[1854736510] 'process raft request'  (duration: 193.245825ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:49.803862Z","caller":"traceutil/trace.go:171","msg":"trace[325789245] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"192.621487ms","start":"2026-02-25T06:07:49.611228Z","end":"2026-02-25T06:07:49.803849Z","steps":["trace[325789245] 'process raft request'  (duration: 192.460713ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:49.80379Z","caller":"traceutil/trace.go:171","msg":"trace[2071373180] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"193.040129ms","start":"2026-02-25T06:07:49.610728Z","end":"2026-02-25T06:07:49.803768Z","steps":["trace[2071373180] 'process raft request'  (duration: 192.926936ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:49.803819Z","caller":"traceutil/trace.go:171","msg":"trace[749709438] linearizableReadLoop","detail":"{readStateIndex:743; appliedIndex:739; }","duration":"187.937948ms","start":"2026-02-25T06:07:49.615855Z","end":"2026-02-25T06:07:49.803793Z","steps":["trace[749709438] 'read index received'  (duration: 141.876409ms)","trace[749709438] 'applied index is now lower than readState.Index'  (duration: 46.060189ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:07:49.803942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.070831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:07:49.803994Z","caller":"traceutil/trace.go:171","msg":"trace[1248337172] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:719; }","duration":"188.158984ms","start":"2026-02-25T06:07:49.615819Z","end":"2026-02-25T06:07:49.803978Z","steps":["trace[1248337172] 'agreement among raft nodes before linearized reading'  (duration: 188.071811ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:49.804093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.207194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-nsdxc\" ","response":"range_response_count:1 size:5023"}
{"level":"info","ts":"2026-02-25T06:07:49.804125Z","caller":"traceutil/trace.go:171","msg":"trace[1261486068] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-nsdxc; range_end:; response_count:1; response_revision:719; }","duration":"157.277015ms","start":"2026-02-25T06:07:49.646838Z","end":"2026-02-25T06:07:49.804115Z","steps":["trace[1261486068] 'agreement among raft nodes before linearized reading'  (duration: 157.128531ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:50.504981Z","caller":"traceutil/trace.go:171","msg":"trace[530109296] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"699.023936ms","start":"2026-02-25T06:07:49.805935Z","end":"2026-02-25T06:07:50.504959Z","steps":["trace[530109296] 'process raft request'  (duration: 698.886473ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:50.505138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:49.805919Z","time spent":"699.147899ms","remote":"127.0.0.1:35992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":817,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/coredns-5dd5756b68-6xx79.1897684fa381f65e\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-5dd5756b68-6xx79.1897684fa381f65e\" value_size:729 lease:4753440088635659522 >> failure:<>"}
{"level":"info","ts":"2026-02-25T06:07:50.511231Z","caller":"traceutil/trace.go:171","msg":"trace[1885513907] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"696.265049ms","start":"2026-02-25T06:07:49.814956Z","end":"2026-02-25T06:07:50.511221Z","steps":["trace[1885513907] 'process raft request'  (duration: 696.197517ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:50.511317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:49.814937Z","time spent":"696.342792ms","remote":"127.0.0.1:36106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4830,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/coredns-77cccfdc44-nsdxc\" mod_revision:685 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-77cccfdc44-nsdxc\" value_size:4771 >> failure:<request_range:<key:\"/registry/pods/kube-system/coredns-77cccfdc44-nsdxc\" > >"}
{"level":"info","ts":"2026-02-25T06:07:51.791014Z","caller":"traceutil/trace.go:171","msg":"trace[2059456466] linearizableReadLoop","detail":"{readStateIndex:752; appliedIndex:751; }","duration":"177.255041ms","start":"2026-02-25T06:07:51.613737Z","end":"2026-02-25T06:07:51.790992Z","steps":["trace[2059456466] 'read index received'  (duration: 177.130347ms)","trace[2059456466] 'applied index is now lower than readState.Index'  (duration: 123.793µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:07:51.791174Z","caller":"traceutil/trace.go:171","msg":"trace[912459761] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"177.683783ms","start":"2026-02-25T06:07:51.613425Z","end":"2026-02-25T06:07:51.791109Z","steps":["trace[912459761] 'process raft request'  (duration: 177.453716ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:51.791203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.427355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:07:51.791285Z","caller":"traceutil/trace.go:171","msg":"trace[907824413] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:727; }","duration":"177.568529ms","start":"2026-02-25T06:07:51.613695Z","end":"2026-02-25T06:07:51.791263Z","steps":["trace[907824413] 'agreement among raft nodes before linearized reading'  (duration: 177.416825ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:52.112058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.569706ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812125490435348 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:716 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T06:07:52.112167Z","caller":"traceutil/trace.go:171","msg":"trace[360145214] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:752; }","duration":"317.076983ms","start":"2026-02-25T06:07:51.795073Z","end":"2026-02-25T06:07:52.11215Z","steps":["trace[360145214] 'read index received'  (duration: 182.040233ms)","trace[360145214] 'applied index is now lower than readState.Index'  (duration: 135.03562ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:07:52.112264Z","caller":"traceutil/trace.go:171","msg":"trace[190427700] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"317.241407ms","start":"2026-02-25T06:07:51.794962Z","end":"2026-02-25T06:07:52.112204Z","steps":["trace[190427700] 'process raft request'  (duration: 182.205458ms)","trace[190427700] 'compare'  (duration: 134.448613ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:07:52.112412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.104145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T06:07:52.112447Z","caller":"traceutil/trace.go:171","msg":"trace[469172208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:728; }","duration":"303.153687ms","start":"2026-02-25T06:07:51.809283Z","end":"2026-02-25T06:07:52.112437Z","steps":["trace[469172208] 'agreement among raft nodes before linearized reading'  (duration: 303.078504ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:52.112483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:51.809273Z","time spent":"303.201908ms","remote":"127.0.0.1:36188","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-25T06:07:52.112474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.167374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"warn","ts":"2026-02-25T06:07:52.112523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.29034ms","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-25T06:07:52.112549Z","caller":"traceutil/trace.go:171","msg":"trace[207267271] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:728; }","duration":"304.280007ms","start":"2026-02-25T06:07:51.808251Z","end":"2026-02-25T06:07:52.112531Z","steps":["trace[207267271] 'agreement among raft nodes before linearized reading'  (duration: 304.02161ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:52.112563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:51.794944Z","time spent":"317.461694ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:716 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-25T06:07:52.112591Z","caller":"traceutil/trace.go:171","msg":"trace[1725501975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:728; }","duration":"303.396533ms","start":"2026-02-25T06:07:51.809178Z","end":"2026-02-25T06:07:52.112574Z","steps":["trace[1725501975] 'agreement among raft nodes before linearized reading'  (duration: 303.188398ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:52.112595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:51.808244Z","time spent":"304.34325ms","remote":"127.0.0.1:36188","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-25T06:07:52.112638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:51.809161Z","time spent":"303.468495ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T06:07:52.112331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.255418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T06:07:52.112721Z","caller":"traceutil/trace.go:171","msg":"trace[2109422061] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:728; }","duration":"317.669159ms","start":"2026-02-25T06:07:51.795044Z","end":"2026-02-25T06:07:52.112713Z","steps":["trace[2109422061] 'agreement among raft nodes before linearized reading'  (duration: 317.188076ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:52.112742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:51.795031Z","time spent":"317.705041ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.204\" "}
{"level":"warn","ts":"2026-02-25T06:07:52.914551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.393446ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812125490435352 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:41f79c93683ad517>","response":"size:41"}
{"level":"warn","ts":"2026-02-25T06:07:52.914656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:52.114398Z","time spent":"800.254996ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-25T06:07:53.13675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.600369ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812125490435353 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:719 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T06:07:53.137142Z","caller":"traceutil/trace.go:171","msg":"trace[2051107868] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"221.54681ms","start":"2026-02-25T06:07:52.915574Z","end":"2026-02-25T06:07:53.137121Z","steps":["trace[2051107868] 'process raft request'  (duration: 221.496459ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:53.137207Z","caller":"traceutil/trace.go:171","msg":"trace[1888600440] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"1.020001827s","start":"2026-02-25T06:07:52.117181Z","end":"2026-02-25T06:07:53.137183Z","steps":["trace[1888600440] 'process raft request'  (duration: 1.019704359s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:53.137324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:52.117166Z","time spent":"1.0200954s","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:717 > 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-25T06:07:53.137408Z","caller":"traceutil/trace.go:171","msg":"trace[1817298703] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"1.018630799s","start":"2026-02-25T06:07:52.118762Z","end":"2026-02-25T06:07:53.137393Z","steps":["trace[1817298703] 'process raft request'  (duration: 1.018256228s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:07:53.137458Z","caller":"traceutil/trace.go:171","msg":"trace[406512780] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"1.021628682s","start":"2026-02-25T06:07:52.115818Z","end":"2026-02-25T06:07:53.137447Z","steps":["trace[406512780] 'process raft request'  (duration: 905.236341ms)","trace[406512780] 'compare'  (duration: 115.469176ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:07:53.137494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:52.115788Z","time spent":"1.021686324s","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:719 > 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-25T06:07:53.13751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:52.118755Z","time spent":"1.0186945s","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:718 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T06:07:53.137689Z","caller":"traceutil/trace.go:171","msg":"trace[210680656] linearizableReadLoop","detail":"{readStateIndex:757; appliedIndex:753; }","duration":"521.797056ms","start":"2026-02-25T06:07:52.615883Z","end":"2026-02-25T06:07:53.13768Z","steps":["trace[210680656] 'read index received'  (duration: 144.291005ms)","trace[210680656] 'applied index is now lower than readState.Index'  (duration: 377.504701ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:07:53.137755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.872128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:07:53.137795Z","caller":"traceutil/trace.go:171","msg":"trace[182306603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:732; }","duration":"521.945781ms","start":"2026-02-25T06:07:52.615841Z","end":"2026-02-25T06:07:53.137787Z","steps":["trace[182306603] 'agreement among raft nodes before linearized reading'  (duration: 521.881679ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:07:53.13782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:07:52.61582Z","time spent":"521.994981ms","remote":"127.0.0.1:56054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T06:08:12.409908Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812125490435531,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T06:08:12.879682Z","caller":"traceutil/trace.go:171","msg":"trace[1944151903] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"971.320085ms","start":"2026-02-25T06:08:11.908339Z","end":"2026-02-25T06:08:12.879659Z","steps":["trace[1944151903] 'process raft request'  (duration: 971.171901ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:12.879822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:11.90832Z","time spent":"971.427099ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:783 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-25T06:08:12.908287Z","caller":"traceutil/trace.go:171","msg":"trace[2092948365] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"999.345052ms","start":"2026-02-25T06:08:11.908914Z","end":"2026-02-25T06:08:12.908259Z","steps":["trace[2092948365] 'read index received'  (duration: 970.886853ms)","trace[2092948365] 'applied index is now lower than readState.Index'  (duration: 28.456969ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:08:12.908862Z","caller":"traceutil/trace.go:171","msg":"trace[601626025] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"822.024589ms","start":"2026-02-25T06:08:12.086822Z","end":"2026-02-25T06:08:12.908846Z","steps":["trace[601626025] 'process raft request'  (duration: 821.251228ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:12.908977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:12.0868Z","time spent":"822.101242ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:760 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-25T06:08:12.909159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.748867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-02-25T06:08:12.909212Z","caller":"traceutil/trace.go:171","msg":"trace[1189144083] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:790; }","duration":"676.837859ms","start":"2026-02-25T06:08:12.232359Z","end":"2026-02-25T06:08:12.909197Z","steps":["trace[1189144083] 'agreement among raft nodes before linearized reading'  (duration: 676.673375ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:12.909255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:12.232338Z","time spent":"676.905671ms","remote":"127.0.0.1:36188","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-25T06:08:12.90946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000545726s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-02-25T06:08:12.909503Z","caller":"traceutil/trace.go:171","msg":"trace[1780865520] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:790; }","duration":"1.000613177s","start":"2026-02-25T06:08:11.908878Z","end":"2026-02-25T06:08:12.909491Z","steps":["trace[1780865520] 'agreement among raft nodes before linearized reading'  (duration: 1.000536345s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:12.909542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:11.908866Z","time spent":"1.000665679s","remote":"127.0.0.1:36194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"warn","ts":"2026-02-25T06:08:12.909641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.146353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:08:12.909687Z","caller":"traceutil/trace.go:171","msg":"trace[1043247889] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:790; }","duration":"487.196814ms","start":"2026-02-25T06:08:12.422477Z","end":"2026-02-25T06:08:12.909674Z","steps":["trace[1043247889] 'agreement among raft nodes before linearized reading'  (duration: 487.123612ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:12.909733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:12.422435Z","time spent":"487.284417ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T06:08:12.909759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.454939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:08:12.909801Z","caller":"traceutil/trace.go:171","msg":"trace[1755810320] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:790; }","duration":"613.522162ms","start":"2026-02-25T06:08:12.296267Z","end":"2026-02-25T06:08:12.909789Z","steps":["trace[1755810320] 'agreement among raft nodes before linearized reading'  (duration: 613.45623ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:12.909838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:12.296255Z","time spent":"613.571853ms","remote":"127.0.0.1:36136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T06:08:12.909996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.913786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:08:12.91004Z","caller":"traceutil/trace.go:171","msg":"trace[1719678229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"294.990968ms","start":"2026-02-25T06:08:12.615037Z","end":"2026-02-25T06:08:12.910028Z","steps":["trace[1719678229] 'agreement among raft nodes before linearized reading'  (duration: 294.918866ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:15.840292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.930143ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812125490435550 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:791 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T06:08:15.840553Z","caller":"traceutil/trace.go:171","msg":"trace[208617336] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"882.754216ms","start":"2026-02-25T06:08:14.957775Z","end":"2026-02-25T06:08:15.840529Z","steps":["trace[208617336] 'process raft request'  (duration: 777.492084ms)","trace[208617336] 'compare'  (duration: 104.83677ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:08:15.840648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:14.957756Z","time spent":"882.842629ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:791 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-25T06:08:15.872219Z","caller":"traceutil/trace.go:171","msg":"trace[1469548571] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:825; }","duration":"575.710273ms","start":"2026-02-25T06:08:15.296488Z","end":"2026-02-25T06:08:15.872199Z","steps":["trace[1469548571] 'read index received'  (duration: 438.825092ms)","trace[1469548571] 'applied index is now lower than readState.Index'  (duration: 136.883541ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:08:15.872379Z","caller":"traceutil/trace.go:171","msg":"trace[784641424] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"637.903619ms","start":"2026-02-25T06:08:15.234414Z","end":"2026-02-25T06:08:15.872318Z","steps":["trace[784641424] 'process raft request'  (duration: 637.616591ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:15.872432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.942739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"warn","ts":"2026-02-25T06:08:15.872432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.16453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:08:15.872472Z","caller":"traceutil/trace.go:171","msg":"trace[1324340766] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:797; }","duration":"576.023811ms","start":"2026-02-25T06:08:15.296438Z","end":"2026-02-25T06:08:15.872462Z","steps":["trace[1324340766] 'agreement among raft nodes before linearized reading'  (duration: 575.867907ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:15.872478Z","caller":"traceutil/trace.go:171","msg":"trace[487324904] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:797; }","duration":"257.257372ms","start":"2026-02-25T06:08:15.615209Z","end":"2026-02-25T06:08:15.872466Z","steps":["trace[487324904] 'agreement among raft nodes before linearized reading'  (duration: 257.17461ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:15.872514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:15.296412Z","time spent":"576.092673ms","remote":"127.0.0.1:36188","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-25T06:08:15.872527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:15.234389Z","time spent":"638.056524ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:769 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-25T06:08:15.872532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.528221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T06:08:15.872619Z","caller":"traceutil/trace.go:171","msg":"trace[795072625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:797; }","duration":"502.679805ms","start":"2026-02-25T06:08:15.369916Z","end":"2026-02-25T06:08:15.872595Z","steps":["trace[795072625] 'agreement among raft nodes before linearized reading'  (duration: 502.430488ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:15.872637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.76643ms","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-25T06:08:15.872729Z","caller":"traceutil/trace.go:171","msg":"trace[823213829] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:797; }","duration":"492.903374ms","start":"2026-02-25T06:08:15.379804Z","end":"2026-02-25T06:08:15.872708Z","steps":["trace[823213829] 'agreement among raft nodes before linearized reading'  (duration: 492.686938ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:15.872816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:15.379784Z","time spent":"493.019028ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T06:08:15.872669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:15.369889Z","time spent":"502.770688ms","remote":"127.0.0.1:36188","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-25T06:08:16.094734Z","caller":"traceutil/trace.go:171","msg":"trace[1687514178] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"216.917512ms","start":"2026-02-25T06:08:15.877781Z","end":"2026-02-25T06:08:16.094699Z","steps":["trace[1687514178] 'process raft request'  (duration: 216.640005ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:16.094866Z","caller":"traceutil/trace.go:171","msg":"trace[101058427] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:828; }","duration":"186.241131ms","start":"2026-02-25T06:08:15.908604Z","end":"2026-02-25T06:08:16.094845Z","steps":["trace[101058427] 'read index received'  (duration: 185.700096ms)","trace[101058427] 'applied index is now lower than readState.Index'  (duration: 539.265µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:08:16.095037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.410305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T06:08:16.095079Z","caller":"traceutil/trace.go:171","msg":"trace[600501560] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:800; }","duration":"186.503228ms","start":"2026-02-25T06:08:15.908564Z","end":"2026-02-25T06:08:16.095067Z","steps":["trace[600501560] 'agreement among raft nodes before linearized reading'  (duration: 186.354304ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:16.095187Z","caller":"traceutil/trace.go:171","msg":"trace[1807325298] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"216.098769ms","start":"2026-02-25T06:08:15.879068Z","end":"2026-02-25T06:08:16.095166Z","steps":["trace[1807325298] 'process raft request'  (duration: 215.585845ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:29.059269Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812125490435746,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T06:08:29.215995Z","caller":"traceutil/trace.go:171","msg":"trace[1987693515] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"992.595136ms","start":"2026-02-25T06:08:28.223371Z","end":"2026-02-25T06:08:29.215967Z","steps":["trace[1987693515] 'process raft request'  (duration: 992.482413ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:29.216133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:28.223356Z","time spent":"992.71094ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:879 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T06:08:29.416813Z","caller":"traceutil/trace.go:171","msg":"trace[299562419] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:916; }","duration":"857.794273ms","start":"2026-02-25T06:08:28.558999Z","end":"2026-02-25T06:08:29.416794Z","steps":["trace[299562419] 'read index received'  (duration: 656.943557ms)","trace[299562419] 'applied index is now lower than readState.Index'  (duration: 200.850086ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:08:29.416892Z","caller":"traceutil/trace.go:171","msg":"trace[1220447947] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"1.193502974s","start":"2026-02-25T06:08:28.223381Z","end":"2026-02-25T06:08:29.416884Z","steps":["trace[1220447947] 'process raft request'  (duration: 1.18041664s)","trace[1220447947] 'compare'  (duration: 12.914839ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:08:29.416959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:28.223369Z","time spent":"1.193538635s","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:878 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-25T06:08:29.41701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.574152ms","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-25T06:08:29.417057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.046707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:08:29.41708Z","caller":"traceutil/trace.go:171","msg":"trace[1572039610] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:884; }","duration":"802.130088ms","start":"2026-02-25T06:08:28.614943Z","end":"2026-02-25T06:08:29.417073Z","steps":["trace[1572039610] 'agreement among raft nodes before linearized reading'  (duration: 802.095687ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:29.417059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.759265ms","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-25T06:08:29.417096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:28.614928Z","time spent":"802.16596ms","remote":"127.0.0.1:56054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T06:08:29.417079Z","caller":"traceutil/trace.go:171","msg":"trace[81177357] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:884; }","duration":"819.698626ms","start":"2026-02-25T06:08:28.597363Z","end":"2026-02-25T06:08:29.417062Z","steps":["trace[81177357] 'agreement among raft nodes before linearized reading'  (duration: 819.564702ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:29.417115Z","caller":"traceutil/trace.go:171","msg":"trace[1683033424] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:884; }","duration":"231.839706ms","start":"2026-02-25T06:08:29.185264Z","end":"2026-02-25T06:08:29.417103Z","steps":["trace[1683033424] 'agreement among raft nodes before linearized reading'  (duration: 231.672061ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:29.417128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:28.597345Z","time spent":"819.771178ms","remote":"127.0.0.1:36222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T06:08:29.417242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.246117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T06:08:29.417269Z","caller":"traceutil/trace.go:171","msg":"trace[1083756616] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:884; }","duration":"858.311158ms","start":"2026-02-25T06:08:28.55895Z","end":"2026-02-25T06:08:29.417261Z","steps":["trace[1083756616] 'agreement among raft nodes before linearized reading'  (duration: 858.259157ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:29.417294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:28.558929Z","time spent":"858.357489ms","remote":"127.0.0.1:36408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "}
{"level":"info","ts":"2026-02-25T06:08:30.116001Z","caller":"traceutil/trace.go:171","msg":"trace[1457590143] linearizableReadLoop","detail":"{readStateIndex:919; appliedIndex:918; }","duration":"500.68492ms","start":"2026-02-25T06:08:29.615293Z","end":"2026-02-25T06:08:30.115978Z","steps":["trace[1457590143] 'read index received'  (duration: 498.17386ms)","trace[1457590143] 'applied index is now lower than readState.Index'  (duration: 2.50969ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:08:30.116346Z","caller":"traceutil/trace.go:171","msg":"trace[1743494177] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"695.465837ms","start":"2026-02-25T06:08:29.420864Z","end":"2026-02-25T06:08:30.116329Z","steps":["trace[1743494177] 'process raft request'  (duration: 692.65999ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:30.116455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:29.420851Z","time spent":"695.534649ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:880 > 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-25T06:08:30.116487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.172769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T06:08:30.11656Z","caller":"traceutil/trace.go:171","msg":"trace[1655716270] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:885; }","duration":"253.293632ms","start":"2026-02-25T06:08:29.863246Z","end":"2026-02-25T06:08:30.11654Z","steps":["trace[1655716270] 'agreement among raft nodes before linearized reading'  (duration: 253.151138ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:30.116737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.896962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-02-25T06:08:30.116741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.109329ms","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-25T06:08:30.1168Z","caller":"traceutil/trace.go:171","msg":"trace[1605340173] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:885; }","duration":"126.987595ms","start":"2026-02-25T06:08:29.989799Z","end":"2026-02-25T06:08:30.116787Z","steps":["trace[1605340173] 'agreement among raft nodes before linearized reading'  (duration: 126.81461ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:30.116755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.444971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:08:30.116812Z","caller":"traceutil/trace.go:171","msg":"trace[1872875777] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:885; }","duration":"127.217432ms","start":"2026-02-25T06:08:29.989583Z","end":"2026-02-25T06:08:30.1168Z","steps":["trace[1872875777] 'agreement among raft nodes before linearized reading'  (duration: 127.058687ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:30.116858Z","caller":"traceutil/trace.go:171","msg":"trace[1121685486] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:885; }","duration":"501.597166ms","start":"2026-02-25T06:08:29.615243Z","end":"2026-02-25T06:08:30.11684Z","steps":["trace[1121685486] 'agreement among raft nodes before linearized reading'  (duration: 501.421041ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:30.116911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:29.615222Z","time spent":"501.680047ms","remote":"127.0.0.1:56054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T06:08:44.646087Z","caller":"traceutil/trace.go:171","msg":"trace[67550118] linearizableReadLoop","detail":"{readStateIndex:962; appliedIndex:961; }","duration":"421.998331ms","start":"2026-02-25T06:08:44.224067Z","end":"2026-02-25T06:08:44.646065Z","steps":["trace[67550118] 'read index received'  (duration: 421.836426ms)","trace[67550118] 'applied index is now lower than readState.Index'  (duration: 161.025µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:08:44.646135Z","caller":"traceutil/trace.go:171","msg":"trace[1512250867] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"463.290825ms","start":"2026-02-25T06:08:44.182822Z","end":"2026-02-25T06:08:44.646113Z","steps":["trace[1512250867] 'process raft request'  (duration: 463.10737ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:44.646292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:44.182807Z","time spent":"463.401819ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:919 > 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-25T06:08:44.646334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.227088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-02-25T06:08:44.646377Z","caller":"traceutil/trace.go:171","msg":"trace[43724911] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:925; }","duration":"422.341121ms","start":"2026-02-25T06:08:44.224027Z","end":"2026-02-25T06:08:44.646368Z","steps":["trace[43724911] 'agreement among raft nodes before linearized reading'  (duration: 422.161796ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:44.646415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:44.224009Z","time spent":"422.398652ms","remote":"127.0.0.1:36188","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-25T06:08:44.646418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.088866ms","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-25T06:08:44.646496Z","caller":"traceutil/trace.go:171","msg":"trace[1983186859] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:925; }","duration":"321.206459ms","start":"2026-02-25T06:08:44.325268Z","end":"2026-02-25T06:08:44.646474Z","steps":["trace[1983186859] 'agreement among raft nodes before linearized reading'  (duration: 321.035154ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:44.646536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:44.325243Z","time spent":"321.28384ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-25T06:08:44.646729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.087028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T06:08:44.646766Z","caller":"traceutil/trace.go:171","msg":"trace[391838269] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:925; }","duration":"272.16592ms","start":"2026-02-25T06:08:44.374588Z","end":"2026-02-25T06:08:44.646754Z","steps":["trace[391838269] 'agreement among raft nodes before linearized reading'  (duration: 272.087898ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:44.863499Z","caller":"traceutil/trace.go:171","msg":"trace[1466476537] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"212.651122ms","start":"2026-02-25T06:08:44.650818Z","end":"2026-02-25T06:08:44.863469Z","steps":["trace[1466476537] 'process raft request'  (duration: 212.57551ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:44.863701Z","caller":"traceutil/trace.go:171","msg":"trace[841913241] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"212.899098ms","start":"2026-02-25T06:08:44.65077Z","end":"2026-02-25T06:08:44.86367Z","steps":["trace[841913241] 'process raft request'  (duration: 120.160989ms)","trace[841913241] 'compare'  (duration: 92.296797ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:08:45.327475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.156451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T06:08:45.327601Z","caller":"traceutil/trace.go:171","msg":"trace[1164178266] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:927; }","duration":"228.346556ms","start":"2026-02-25T06:08:45.099228Z","end":"2026-02-25T06:08:45.327574Z","steps":["trace[1164178266] 'count revisions from in-memory index tree'  (duration: 228.078068ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:45.497035Z","caller":"traceutil/trace.go:171","msg":"trace[1140661690] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"151.527358ms","start":"2026-02-25T06:08:45.345489Z","end":"2026-02-25T06:08:45.497016Z","steps":["trace[1140661690] 'process raft request'  (duration: 151.174879ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:46.796003Z","caller":"traceutil/trace.go:171","msg":"trace[147774736] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:966; }","duration":"179.957916ms","start":"2026-02-25T06:08:46.615992Z","end":"2026-02-25T06:08:46.79595Z","steps":["trace[147774736] 'read index received'  (duration: 179.724739ms)","trace[147774736] 'applied index is now lower than readState.Index'  (duration: 232.177µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:08:46.796167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.152211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:08:46.796025Z","caller":"traceutil/trace.go:171","msg":"trace[1910902622] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"428.490181ms","start":"2026-02-25T06:08:46.367506Z","end":"2026-02-25T06:08:46.795996Z","steps":["trace[1910902622] 'process raft request'  (duration: 428.305176ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:46.796261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.330824ms","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-25T06:08:46.796506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:46.367491Z","time spent":"428.867161ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:905 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-02-25T06:08:46.796524Z","caller":"traceutil/trace.go:171","msg":"trace[532700572] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:930; }","duration":"146.575891ms","start":"2026-02-25T06:08:46.649871Z","end":"2026-02-25T06:08:46.796447Z","steps":["trace[532700572] 'agreement among raft nodes before linearized reading'  (duration: 146.275152ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:46.796253Z","caller":"traceutil/trace.go:171","msg":"trace[2002005370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:930; }","duration":"180.293105ms","start":"2026-02-25T06:08:46.615947Z","end":"2026-02-25T06:08:46.79624Z","steps":["trace[2002005370] 'agreement among raft nodes before linearized reading'  (duration: 180.160291ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:47.369295Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812125490435885,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T06:08:47.604125Z","caller":"traceutil/trace.go:171","msg":"trace[899261302] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"801.986648ms","start":"2026-02-25T06:08:46.802119Z","end":"2026-02-25T06:08:47.604106Z","steps":["trace[899261302] 'process raft request'  (duration: 733.525022ms)","trace[899261302] 'compare'  (duration: 68.031394ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:08:47.604253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:46.802069Z","time spent":"802.109501ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:925 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T06:08:47.753145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.287896ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812125490435887 > lease_revoke:<id:41f79c93683ad6b4>","response":"size:29"}
{"level":"info","ts":"2026-02-25T06:08:47.753226Z","caller":"traceutil/trace.go:171","msg":"trace[1483387585] linearizableReadLoop","detail":"{readStateIndex:969; appliedIndex:967; }","duration":"884.253937ms","start":"2026-02-25T06:08:46.868959Z","end":"2026-02-25T06:08:47.753213Z","steps":["trace[1483387585] 'read index received'  (duration: 666.69904ms)","trace[1483387585] 'applied index is now lower than readState.Index'  (duration: 217.553807ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:08:47.753377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.413641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-02-25T06:08:47.753398Z","caller":"traceutil/trace.go:171","msg":"trace[1304179451] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:931; }","duration":"884.488374ms","start":"2026-02-25T06:08:46.868903Z","end":"2026-02-25T06:08:47.753391Z","steps":["trace[1304179451] 'agreement among raft nodes before linearized reading'  (duration: 884.382401ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:47.753424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:46.868878Z","time spent":"884.540705ms","remote":"127.0.0.1:36188","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-25T06:08:47.753501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.316426ms","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-25T06:08:47.753568Z","caller":"traceutil/trace.go:171","msg":"trace[1088753434] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:931; }","duration":"881.413288ms","start":"2026-02-25T06:08:46.872136Z","end":"2026-02-25T06:08:47.753549Z","steps":["trace[1088753434] 'agreement among raft nodes before linearized reading'  (duration: 881.226553ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:47.753609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:46.872125Z","time spent":"881.475811ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-25T06:08:47.753723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.812763ms","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-25T06:08:47.753744Z","caller":"traceutil/trace.go:171","msg":"trace[1792813602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:931; }","duration":"222.854814ms","start":"2026-02-25T06:08:47.530883Z","end":"2026-02-25T06:08:47.753738Z","steps":["trace[1792813602] 'agreement among raft nodes before linearized reading'  (duration: 222.798022ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:47.753829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.886614ms","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-25T06:08:47.753861Z","caller":"traceutil/trace.go:171","msg":"trace[1987737303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:931; }","duration":"253.955486ms","start":"2026-02-25T06:08:47.499897Z","end":"2026-02-25T06:08:47.753852Z","steps":["trace[1987737303] 'agreement among raft nodes before linearized reading'  (duration: 253.867453ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:49.093076Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.272543544s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T06:08:49.093651Z","caller":"traceutil/trace.go:171","msg":"trace[845745735] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"1.334334715s","start":"2026-02-25T06:08:47.759288Z","end":"2026-02-25T06:08:49.093622Z","steps":["trace[845745735] 'process raft request'  (duration: 1.334280304s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:49.093826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:47.759268Z","time spent":"1.33446976s","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:928 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T06:08:49.093837Z","caller":"traceutil/trace.go:171","msg":"trace[934404660] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"1.336511346s","start":"2026-02-25T06:08:47.757306Z","end":"2026-02-25T06:08:49.093817Z","steps":["trace[934404660] 'process raft request'  (duration: 1.335984521s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:49.093943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:47.757275Z","time spent":"1.336610949s","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:927 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-25T06:08:49.093956Z","caller":"traceutil/trace.go:171","msg":"trace[1817355450] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"1.336486525s","start":"2026-02-25T06:08:47.757421Z","end":"2026-02-25T06:08:49.093907Z","steps":["trace[1817355450] 'process raft request'  (duration: 1.336067824s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:49.094157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:47.757399Z","time spent":"1.3366451s","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:926 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-25T06:08:49.135349Z","caller":"traceutil/trace.go:171","msg":"trace[1525248822] linearizableReadLoop","detail":"{readStateIndex:974; appliedIndex:970; }","duration":"520.413547ms","start":"2026-02-25T06:08:48.614912Z","end":"2026-02-25T06:08:49.135326Z","steps":["trace[1525248822] 'read index received'  (duration: 478.347041ms)","trace[1525248822] 'applied index is now lower than readState.Index'  (duration: 42.065036ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:08:49.135385Z","caller":"traceutil/trace.go:171","msg":"trace[635904044] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"1.214764163s","start":"2026-02-25T06:08:47.920591Z","end":"2026-02-25T06:08:49.135355Z","steps":["trace[635904044] 'process raft request'  (duration: 1.214604088s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:49.13549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.552081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:08:49.135529Z","caller":"traceutil/trace.go:171","msg":"trace[316218832] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:936; }","duration":"520.648454ms","start":"2026-02-25T06:08:48.61487Z","end":"2026-02-25T06:08:49.135518Z","steps":["trace[316218832] 'agreement among raft nodes before linearized reading'  (duration: 520.536561ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:49.135517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:47.920567Z","time spent":"1.214885436s","remote":"127.0.0.1:35992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":816,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-smtlr.1897685d349ec728\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-smtlr.1897685d349ec728\" value_size:723 lease:4753440088635659522 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T06:08:49.135568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:48.614851Z","time spent":"520.709665ms","remote":"127.0.0.1:56054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T06:08:49.78419Z","caller":"traceutil/trace.go:171","msg":"trace[2014734370] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"114.78979ms","start":"2026-02-25T06:08:49.66937Z","end":"2026-02-25T06:08:49.78416Z","steps":["trace[2014734370] 'process raft request'  (duration: 114.621486ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:51.299451Z","caller":"traceutil/trace.go:171","msg":"trace[2123343284] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"196.828643ms","start":"2026-02-25T06:08:51.102594Z","end":"2026-02-25T06:08:51.299423Z","steps":["trace[2123343284] 'process raft request'  (duration: 196.689069ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:51.352201Z","caller":"traceutil/trace.go:171","msg":"trace[846151382] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"248.778623ms","start":"2026-02-25T06:08:51.103399Z","end":"2026-02-25T06:08:51.352178Z","steps":["trace[846151382] 'process raft request'  (duration: 248.738282ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:51.352277Z","caller":"traceutil/trace.go:171","msg":"trace[1284317649] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"249.432251ms","start":"2026-02-25T06:08:51.102809Z","end":"2026-02-25T06:08:51.352241Z","steps":["trace[1284317649] 'process raft request'  (duration: 249.209714ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:51.970863Z","caller":"traceutil/trace.go:171","msg":"trace[1876938003] linearizableReadLoop","detail":"{readStateIndex:983; appliedIndex:982; }","duration":"190.679202ms","start":"2026-02-25T06:08:51.780162Z","end":"2026-02-25T06:08:51.970841Z","steps":["trace[1876938003] 'read index received'  (duration: 190.515788ms)","trace[1876938003] 'applied index is now lower than readState.Index'  (duration: 162.654µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:08:51.970966Z","caller":"traceutil/trace.go:171","msg":"trace[1198366808] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"352.911568ms","start":"2026-02-25T06:08:51.618045Z","end":"2026-02-25T06:08:51.970957Z","steps":["trace[1198366808] 'process raft request'  (duration: 352.687861ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:51.971047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:51.618033Z","time spent":"352.958599ms","remote":"127.0.0.1:35992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":799,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-smtlr.1897685e0d872695\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-smtlr.1897685e0d872695\" value_size:706 lease:4753440088635660101 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T06:08:51.971549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.373792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:08:51.971652Z","caller":"traceutil/trace.go:171","msg":"trace[460128903] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:944; }","duration":"191.509366ms","start":"2026-02-25T06:08:51.780131Z","end":"2026-02-25T06:08:51.971641Z","steps":["trace[460128903] 'agreement among raft nodes before linearized reading'  (duration: 191.329681ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:51.972025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.18089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-25T06:08:51.972102Z","caller":"traceutil/trace.go:171","msg":"trace[1221777308] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:944; }","duration":"181.279862ms","start":"2026-02-25T06:08:51.790811Z","end":"2026-02-25T06:08:51.972091Z","steps":["trace[1221777308] 'agreement among raft nodes before linearized reading'  (duration: 181.014925ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:51.972429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.830647ms","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-25T06:08:51.972813Z","caller":"traceutil/trace.go:171","msg":"trace[417355457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:944; }","duration":"117.255319ms","start":"2026-02-25T06:08:51.855545Z","end":"2026-02-25T06:08:51.9728Z","steps":["trace[417355457] 'agreement among raft nodes before linearized reading'  (duration: 116.807276ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:51.972715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.592305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T06:08:51.973425Z","caller":"traceutil/trace.go:171","msg":"trace[169836210] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:944; }","duration":"176.320905ms","start":"2026-02-25T06:08:51.797091Z","end":"2026-02-25T06:08:51.973412Z","steps":["trace[169836210] 'agreement among raft nodes before linearized reading'  (duration: 175.525343ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:52.276692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.75263ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812125490435921 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:41f79c93683ad750>","response":"size:41"}
{"level":"warn","ts":"2026-02-25T06:08:52.276835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:51.975697Z","time spent":"301.134682ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-25T06:08:52.358433Z","caller":"traceutil/trace.go:171","msg":"trace[620321358] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"381.870239ms","start":"2026-02-25T06:08:51.97654Z","end":"2026-02-25T06:08:52.35841Z","steps":["trace[620321358] 'process raft request'  (duration: 381.827068ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:52.358577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:51.976536Z","time spent":"381.969682ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:938 > 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-25T06:08:52.358899Z","caller":"traceutil/trace.go:171","msg":"trace[912459052] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"382.392773ms","start":"2026-02-25T06:08:51.976495Z","end":"2026-02-25T06:08:52.358888Z","steps":["trace[912459052] 'process raft request'  (duration: 381.737455ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:52.358965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:51.976485Z","time spent":"382.449415ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:937 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T06:08:53.520134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.750941ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812125490435924 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.204\" mod_revision:918 > success:<request_put:<key:\"/registry/masterleases/162.253.55.204\" value_size:67 lease:4753440088635660112 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.204\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T06:08:53.520219Z","caller":"traceutil/trace.go:171","msg":"trace[33675810] linearizableReadLoop","detail":"{readStateIndex:987; appliedIndex:986; }","duration":"689.881063ms","start":"2026-02-25T06:08:52.830324Z","end":"2026-02-25T06:08:53.520205Z","steps":["trace[33675810] 'read index received'  (duration: 52.887155ms)","trace[33675810] 'applied index is now lower than readState.Index'  (duration: 636.992578ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:08:53.520301Z","caller":"traceutil/trace.go:171","msg":"trace[1327935057] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"1.242563444s","start":"2026-02-25T06:08:52.277727Z","end":"2026-02-25T06:08:53.520291Z","steps":["trace[1327935057] 'process raft request'  (duration: 605.565756ms)","trace[1327935057] 'compare'  (duration: 636.614498ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:08:53.520351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:52.277711Z","time spent":"1.242612535s","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.204\" mod_revision:918 > success:<request_put:<key:\"/registry/masterleases/162.253.55.204\" value_size:67 lease:4753440088635660112 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.204\" > >"}
{"level":"warn","ts":"2026-02-25T06:08:53.520579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.261344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:08:53.520607Z","caller":"traceutil/trace.go:171","msg":"trace[292058469] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:947; }","duration":"690.323926ms","start":"2026-02-25T06:08:52.830274Z","end":"2026-02-25T06:08:53.520598Z","steps":["trace[292058469] 'agreement among raft nodes before linearized reading'  (duration: 690.255084ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:53.520633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:52.830253Z","time spent":"690.372666ms","remote":"127.0.0.1:56054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T06:08:53.520885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.376494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T06:08:53.520913Z","caller":"traceutil/trace.go:171","msg":"trace[1456364016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:947; }","duration":"216.428666ms","start":"2026-02-25T06:08:53.304476Z","end":"2026-02-25T06:08:53.520905Z","steps":["trace[1456364016] 'agreement among raft nodes before linearized reading'  (duration: 216.331704ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:53.521097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.915379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-02-25T06:08:53.521176Z","caller":"traceutil/trace.go:171","msg":"trace[490270135] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:947; }","duration":"165.004351ms","start":"2026-02-25T06:08:53.356158Z","end":"2026-02-25T06:08:53.521162Z","steps":["trace[490270135] 'agreement among raft nodes before linearized reading'  (duration: 164.814386ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:53.521256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.125895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-02-25T06:08:53.521284Z","caller":"traceutil/trace.go:171","msg":"trace[1112926339] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:947; }","duration":"165.178316ms","start":"2026-02-25T06:08:53.356097Z","end":"2026-02-25T06:08:53.521275Z","steps":["trace[1112926339] 'agreement among raft nodes before linearized reading'  (duration: 164.93638ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:53.909033Z","caller":"traceutil/trace.go:171","msg":"trace[1998817175] linearizableReadLoop","detail":"{readStateIndex:989; appliedIndex:987; }","duration":"382.149587ms","start":"2026-02-25T06:08:53.526861Z","end":"2026-02-25T06:08:53.909011Z","steps":["trace[1998817175] 'read index received'  (duration: 51.860227ms)","trace[1998817175] 'applied index is now lower than readState.Index'  (duration: 330.28832ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:08:53.909163Z","caller":"traceutil/trace.go:171","msg":"trace[1254497366] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"381.5423ms","start":"2026-02-25T06:08:53.527598Z","end":"2026-02-25T06:08:53.90914Z","steps":["trace[1254497366] 'process raft request'  (duration: 381.371485ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:53.909243Z","caller":"traceutil/trace.go:171","msg":"trace[634807927] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"383.145675ms","start":"2026-02-25T06:08:53.526072Z","end":"2026-02-25T06:08:53.909218Z","steps":["trace[634807927] 'process raft request'  (duration: 303.333294ms)","trace[634807927] 'compare'  (duration: 79.460971ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:08:53.909287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:53.527587Z","time spent":"381.624973ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:939 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-25T06:08:53.909373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:53.526063Z","time spent":"383.235247ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:940 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-25T06:08:53.909373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.485477ms","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-25T06:08:53.909441Z","caller":"traceutil/trace.go:171","msg":"trace[135830099] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:950; }","duration":"382.577509ms","start":"2026-02-25T06:08:53.526846Z","end":"2026-02-25T06:08:53.909424Z","steps":["trace[135830099] 'agreement among raft nodes before linearized reading'  (duration: 382.375693ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:53.90948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:08:53.52684Z","time spent":"382.63133ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "}
{"level":"info","ts":"2026-02-25T06:08:53.912027Z","caller":"traceutil/trace.go:171","msg":"trace[348646827] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"123.775979ms","start":"2026-02-25T06:08:53.788241Z","end":"2026-02-25T06:08:53.912016Z","steps":["trace[348646827] 'process raft request'  (duration: 123.500312ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:53.912116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.835724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:08:53.912187Z","caller":"traceutil/trace.go:171","msg":"trace[806726624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:951; }","duration":"296.928705ms","start":"2026-02-25T06:08:53.615233Z","end":"2026-02-25T06:08:53.912162Z","steps":["trace[806726624] 'agreement among raft nodes before linearized reading'  (duration: 296.827493ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:56.049859Z","caller":"traceutil/trace.go:171","msg":"trace[659306300] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"113.083543ms","start":"2026-02-25T06:08:55.936749Z","end":"2026-02-25T06:08:56.049833Z","steps":["trace[659306300] 'process raft request'  (duration: 112.920329ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:56.059643Z","caller":"traceutil/trace.go:171","msg":"trace[1418097552] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"121.224608ms","start":"2026-02-25T06:08:55.938391Z","end":"2026-02-25T06:08:56.059616Z","steps":["trace[1418097552] 'process raft request'  (duration: 121.058753ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:58.519008Z","caller":"traceutil/trace.go:171","msg":"trace[1329569916] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"123.393188ms","start":"2026-02-25T06:08:58.395589Z","end":"2026-02-25T06:08:58.518982Z","steps":["trace[1329569916] 'process raft request'  (duration: 123.256254ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:58.550112Z","caller":"traceutil/trace.go:171","msg":"trace[659380255] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"152.848075ms","start":"2026-02-25T06:08:58.39724Z","end":"2026-02-25T06:08:58.550088Z","steps":["trace[659380255] 'process raft request'  (duration: 152.66665ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:08:58.839211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.999156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:08:58.839474Z","caller":"traceutil/trace.go:171","msg":"trace[34585129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:981; }","duration":"224.299474ms","start":"2026-02-25T06:08:58.615139Z","end":"2026-02-25T06:08:58.839438Z","steps":["trace[34585129] 'range keys from in-memory index tree'  (duration: 223.897263ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:08:59.737708Z","caller":"traceutil/trace.go:171","msg":"trace[1379735539] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"131.046061ms","start":"2026-02-25T06:08:59.606639Z","end":"2026-02-25T06:08:59.737685Z","steps":["trace[1379735539] 'process raft request'  (duration: 130.924618ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:09:02.722124Z","caller":"traceutil/trace.go:171","msg":"trace[1669769345] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1039; }","duration":"162.4ms","start":"2026-02-25T06:09:02.559701Z","end":"2026-02-25T06:09:02.722101Z","steps":["trace[1669769345] 'read index received'  (duration: 162.198884ms)","trace[1669769345] 'applied index is now lower than readState.Index'  (duration: 199.906µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:09:02.722214Z","caller":"traceutil/trace.go:171","msg":"trace[978142247] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"188.625765ms","start":"2026-02-25T06:09:02.533564Z","end":"2026-02-25T06:09:02.72219Z","steps":["trace[978142247] 'process raft request'  (duration: 188.407579ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:09:02.722331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.612566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-25T06:09:02.72237Z","caller":"traceutil/trace.go:171","msg":"trace[12475751] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:998; }","duration":"162.701738ms","start":"2026-02-25T06:09:02.559655Z","end":"2026-02-25T06:09:02.722357Z","steps":["trace[12475751] 'agreement among raft nodes before linearized reading'  (duration: 162.562134ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:11:31.712166Z","caller":"traceutil/trace.go:171","msg":"trace[401292868] transaction","detail":"{read_only:false; response_revision:1633; number_of_response:1; }","duration":"116.232281ms","start":"2026-02-25T06:11:31.595907Z","end":"2026-02-25T06:11:31.712139Z","steps":["trace[401292868] 'process raft request'  (duration: 104.184272ms)","trace[401292868] 'compare'  (duration: 11.938086ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:11:33.427463Z","caller":"traceutil/trace.go:171","msg":"trace[959298389] linearizableReadLoop","detail":"{readStateIndex:1709; appliedIndex:1708; }","duration":"204.355033ms","start":"2026-02-25T06:11:33.223083Z","end":"2026-02-25T06:11:33.427438Z","steps":["trace[959298389] 'read index received'  (duration: 204.23107ms)","trace[959298389] 'applied index is now lower than readState.Index'  (duration: 122.923µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:11:33.427551Z","caller":"traceutil/trace.go:171","msg":"trace[877771592] transaction","detail":"{read_only:false; response_revision:1637; number_of_response:1; }","duration":"208.016083ms","start":"2026-02-25T06:11:33.219507Z","end":"2026-02-25T06:11:33.427523Z","steps":["trace[877771592] 'process raft request'  (duration: 207.780007ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:11:33.427678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.57947ms","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-25T06:11:33.427763Z","caller":"traceutil/trace.go:171","msg":"trace[583757310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1637; }","duration":"204.683603ms","start":"2026-02-25T06:11:33.223035Z","end":"2026-02-25T06:11:33.427719Z","steps":["trace[583757310] 'agreement among raft nodes before linearized reading'  (duration: 204.505348ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:11:55.774127Z","caller":"traceutil/trace.go:171","msg":"trace[445190722] transaction","detail":"{read_only:false; response_revision:1737; number_of_response:1; }","duration":"135.512779ms","start":"2026-02-25T06:11:55.638582Z","end":"2026-02-25T06:11:55.774095Z","steps":["trace[445190722] 'process raft request'  (duration: 118.769797ms)","trace[445190722] 'compare'  (duration: 16.618009ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:12:03.625245Z","caller":"traceutil/trace.go:171","msg":"trace[805383106] transaction","detail":"{read_only:false; response_revision:1786; number_of_response:1; }","duration":"109.766569ms","start":"2026-02-25T06:12:03.515448Z","end":"2026-02-25T06:12:03.625215Z","steps":["trace[805383106] 'process raft request'  (duration: 109.515402ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:12:10.169135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.177318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-02-25T06:12:10.169229Z","caller":"traceutil/trace.go:171","msg":"trace[1332822861] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1817; }","duration":"186.323762ms","start":"2026-02-25T06:12:09.982886Z","end":"2026-02-25T06:12:10.16921Z","steps":["trace[1332822861] 'range keys from in-memory index tree'  (duration: 185.929061ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:12:10.169264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.26718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-25T06:12:10.169318Z","caller":"traceutil/trace.go:171","msg":"trace[642700468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1817; }","duration":"186.360113ms","start":"2026-02-25T06:12:09.982941Z","end":"2026-02-25T06:12:10.169301Z","steps":["trace[642700468] 'range keys from in-memory index tree'  (duration: 186.127506ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:12:10.984261Z","caller":"traceutil/trace.go:171","msg":"trace[1846389125] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"128.817555ms","start":"2026-02-25T06:12:10.855403Z","end":"2026-02-25T06:12:10.984221Z","steps":["trace[1846389125] 'process raft request'  (duration: 128.420734ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:12:11.303062Z","caller":"traceutil/trace.go:171","msg":"trace[1147645319] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"313.289266ms","start":"2026-02-25T06:12:10.98975Z","end":"2026-02-25T06:12:11.303039Z","steps":["trace[1147645319] 'process raft request'  (duration: 313.150862ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:12:11.303214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:12:10.989721Z","time spent":"313.416038ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1797 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-02-25T06:12:11.397762Z","caller":"traceutil/trace.go:171","msg":"trace[658836108] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1902; }","duration":"111.648971ms","start":"2026-02-25T06:12:11.286083Z","end":"2026-02-25T06:12:11.397732Z","steps":["trace[658836108] 'read index received'  (duration: 16.835494ms)","trace[658836108] 'applied index is now lower than readState.Index'  (duration: 94.812097ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:12:11.397889Z","caller":"traceutil/trace.go:171","msg":"trace[1122248551] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"407.577638ms","start":"2026-02-25T06:12:10.990283Z","end":"2026-02-25T06:12:11.39786Z","steps":["trace[1122248551] 'process raft request'  (duration: 392.934524ms)","trace[1122248551] 'compare'  (duration: 14.381746ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:12:11.398004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.915049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"warn","ts":"2026-02-25T06:12:11.398029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:12:10.990255Z","time spent":"407.687741ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1812 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-25T06:12:11.398038Z","caller":"traceutil/trace.go:171","msg":"trace[1703058231] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1824; }","duration":"112.005691ms","start":"2026-02-25T06:12:11.286022Z","end":"2026-02-25T06:12:11.398027Z","steps":["trace[1703058231] 'agreement among raft nodes before linearized reading'  (duration: 111.821516ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:12:14.426174Z","caller":"traceutil/trace.go:171","msg":"trace[212895284] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1920; }","duration":"162.817053ms","start":"2026-02-25T06:12:14.263331Z","end":"2026-02-25T06:12:14.426148Z","steps":["trace[212895284] 'read index received'  (duration: 162.601357ms)","trace[212895284] 'applied index is now lower than readState.Index'  (duration: 214.376µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:12:14.426239Z","caller":"traceutil/trace.go:171","msg":"trace[864474036] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"169.771495ms","start":"2026-02-25T06:12:14.256432Z","end":"2026-02-25T06:12:14.426203Z","steps":["trace[864474036] 'process raft request'  (duration: 169.540489ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:12:14.426469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.121761ms","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-25T06:12:14.426578Z","caller":"traceutil/trace.go:171","msg":"trace[1738611656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1840; }","duration":"163.284527ms","start":"2026-02-25T06:12:14.263271Z","end":"2026-02-25T06:12:14.426556Z","steps":["trace[1738611656] 'agreement among raft nodes before linearized reading'  (duration: 163.005159ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:12:19.814146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.770288ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812125490438344 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1853 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T06:12:19.814354Z","caller":"traceutil/trace.go:171","msg":"trace[45980891] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1941; }","duration":"307.181427ms","start":"2026-02-25T06:12:19.507153Z","end":"2026-02-25T06:12:19.814335Z","steps":["trace[45980891] 'read index received'  (duration: 55.024578ms)","trace[45980891] 'applied index is now lower than readState.Index'  (duration: 252.155359ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:12:19.814409Z","caller":"traceutil/trace.go:171","msg":"trace[784662690] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"322.009986ms","start":"2026-02-25T06:12:19.492358Z","end":"2026-02-25T06:12:19.814368Z","steps":["trace[784662690] 'process raft request'  (duration: 69.825367ms)","trace[784662690] 'compare'  (duration: 251.602903ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:12:19.814559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.392012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:949"}
{"level":"warn","ts":"2026-02-25T06:12:19.81459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.323725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pvc-protection-controller\" ","response":"range_response_count:1 size:728"}
{"level":"info","ts":"2026-02-25T06:12:19.814643Z","caller":"traceutil/trace.go:171","msg":"trace[428584429] range","detail":"{range_begin:/registry/clusterrolebindings/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:1860; }","duration":"307.512586ms","start":"2026-02-25T06:12:19.50711Z","end":"2026-02-25T06:12:19.814622Z","steps":["trace[428584429] 'agreement among raft nodes before linearized reading'  (duration: 307.31584ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:12:19.814657Z","caller":"traceutil/trace.go:171","msg":"trace[384155886] range","detail":"{range_begin:/registry/clusterroles/system:controller:pvc-protection-controller; range_end:; response_count:1; response_revision:1860; }","duration":"251.419078ms","start":"2026-02-25T06:12:19.56322Z","end":"2026-02-25T06:12:19.814639Z","steps":["trace[384155886] 'agreement among raft nodes before linearized reading'  (duration: 251.281234ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:12:19.814685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:12:19.507096Z","time spent":"307.581128ms","remote":"127.0.0.1:36278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":973,"request content":"key:\"/registry/clusterrolebindings/ceph-csi-rbd-provisioner\" "}
{"level":"warn","ts":"2026-02-25T06:12:19.814584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:12:19.492347Z","time spent":"322.14642ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1853 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >"}
{"level":"info","ts":"2026-02-25T06:12:20.225505Z","caller":"traceutil/trace.go:171","msg":"trace[1627012542] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1942; }","duration":"317.635676ms","start":"2026-02-25T06:12:19.907841Z","end":"2026-02-25T06:12:20.225477Z","steps":["trace[1627012542] 'read index received'  (duration: 293.246163ms)","trace[1627012542] 'applied index is now lower than readState.Index'  (duration: 24.388283ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:12:20.225631Z","caller":"traceutil/trace.go:171","msg":"trace[804100838] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"322.075968ms","start":"2026-02-25T06:12:19.903527Z","end":"2026-02-25T06:12:20.225603Z","steps":["trace[804100838] 'process raft request'  (duration: 297.659104ms)","trace[804100838] 'compare'  (duration: 24.179588ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:12:20.225755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.895853ms","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-25T06:12:20.225759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:12:19.90351Z","time spent":"322.176801ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1854 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T06:12:20.225791Z","caller":"traceutil/trace.go:171","msg":"trace[1291005494] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1861; }","duration":"317.984735ms","start":"2026-02-25T06:12:19.907795Z","end":"2026-02-25T06:12:20.225779Z","steps":["trace[1291005494] 'agreement among raft nodes before linearized reading'  (duration: 317.831801ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:12:20.225858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:12:19.90777Z","time spent":"318.079158ms","remote":"127.0.0.1:36188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-25T06:12:20.225928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.389423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:replicaset-controller\" ","response":"range_response_count:1 size:843"}
{"level":"info","ts":"2026-02-25T06:12:20.225959Z","caller":"traceutil/trace.go:171","msg":"trace[1964343536] range","detail":"{range_begin:/registry/clusterroles/system:controller:replicaset-controller; range_end:; response_count:1; response_revision:1861; }","duration":"257.463255ms","start":"2026-02-25T06:12:19.968487Z","end":"2026-02-25T06:12:20.22595Z","steps":["trace[1964343536] 'agreement among raft nodes before linearized reading'  (duration: 257.401343ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:12:20.226061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.029747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cilium\" ","response":"range_response_count:1 size:749"}
{"level":"info","ts":"2026-02-25T06:12:20.226135Z","caller":"traceutil/trace.go:171","msg":"trace[1475354833] range","detail":"{range_begin:/registry/clusterrolebindings/cilium; range_end:; response_count:1; response_revision:1861; }","duration":"243.134049ms","start":"2026-02-25T06:12:19.982984Z","end":"2026-02-25T06:12:20.226118Z","steps":["trace[1475354833] 'agreement among raft nodes before linearized reading'  (duration: 242.969395ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:12:40.678312Z","caller":"traceutil/trace.go:171","msg":"trace[1590736636] transaction","detail":"{read_only:false; response_revision:1950; number_of_response:1; }","duration":"101.206943ms","start":"2026-02-25T06:12:40.577076Z","end":"2026-02-25T06:12:40.678283Z","steps":["trace[1590736636] 'process raft request'  (duration: 83.484924ms)","trace[1590736636] 'compare'  (duration: 17.512763ms)"],"step_count":2}