{"level":"warn","ts":"2026-02-26T16:46:35.025977Z","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-26T16:46:35.02614Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.12: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.12:2380","--initial-cluster=instance=https://162.253.55.12:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.12:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.12: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-26T16:46:35.026238Z","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-26T16:46:35.026254Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.12:2380"]}
{"level":"info","ts":"2026-02-26T16:46:35.026333Z","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-26T16:46:35.027101Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"]}
{"level":"info","ts":"2026-02-26T16:46:35.027184Z","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.12:2380"],"listen-peer-urls":["https://162.253.55.12:2380"],"advertise-client-urls":["https://162.253.55.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.12: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-26T16:46:35.031427Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.972004ms"}
{"level":"info","ts":"2026-02-26T16:46:35.04159Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b4c6dc24a78438ca","cluster-id":"587227f9a3f73e98"}
{"level":"info","ts":"2026-02-26T16:46:35.041674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=()"}
{"level":"info","ts":"2026-02-26T16:46:35.0417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became follower at term 0"}
{"level":"info","ts":"2026-02-26T16:46:35.041711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b4c6dc24a78438ca [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-26T16:46:35.041719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became follower at term 1"}
{"level":"info","ts":"2026-02-26T16:46:35.041766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=(13026341022203132106)"}
{"level":"warn","ts":"2026-02-26T16:46:35.048219Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-26T16:46:35.051396Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-26T16:46:35.058597Z","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-26T16:46:35.061107Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b4c6dc24a78438ca","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-26T16:46:35.061626Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b4c6dc24a78438ca","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-26T16:46:35.061755Z","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-26T16:46:35.061891Z","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-26T16:46:35.061902Z","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-26T16:46:35.062363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=(13026341022203132106)"}
{"level":"info","ts":"2026-02-26T16:46:35.062611Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"587227f9a3f73e98","local-member-id":"b4c6dc24a78438ca","added-peer-id":"b4c6dc24a78438ca","added-peer-peer-urls":["https://162.253.55.12:2380"]}
{"level":"info","ts":"2026-02-26T16:46:35.066742Z","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-26T16:46:35.066842Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.12:2380"}
{"level":"info","ts":"2026-02-26T16:46:35.066863Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.12:2380"}
{"level":"info","ts":"2026-02-26T16:46:35.067172Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b4c6dc24a78438ca","initial-advertise-peer-urls":["https://162.253.55.12:2380"],"listen-peer-urls":["https://162.253.55.12:2380"],"advertise-client-urls":["https://162.253.55.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-26T16:46:35.067223Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-26T16:46:35.442387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca is starting a new election at term 1"}
{"level":"info","ts":"2026-02-26T16:46:35.442632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-26T16:46:35.442715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca received MsgPreVoteResp from b4c6dc24a78438ca at term 1"}
{"level":"info","ts":"2026-02-26T16:46:35.442773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became candidate at term 2"}
{"level":"info","ts":"2026-02-26T16:46:35.442839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca received MsgVoteResp from b4c6dc24a78438ca at term 2"}
{"level":"info","ts":"2026-02-26T16:46:35.442908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became leader at term 2"}
{"level":"info","ts":"2026-02-26T16:46:35.442957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b4c6dc24a78438ca elected leader b4c6dc24a78438ca at term 2"}
{"level":"info","ts":"2026-02-26T16:46:35.444196Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b4c6dc24a78438ca","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.12:2379]}","request-path":"/0/members/b4c6dc24a78438ca/attributes","cluster-id":"587227f9a3f73e98","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-26T16:46:35.444313Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-26T16:46:35.444497Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-26T16:46:35.444796Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-26T16:46:35.444861Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-26T16:46:35.444364Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-26T16:46:35.445571Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"587227f9a3f73e98","local-member-id":"b4c6dc24a78438ca","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-26T16:46:35.445738Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-26T16:46:35.44584Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-26T16:46:35.44831Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-26T16:46:35.449196Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.12:2379"}
{"level":"info","ts":"2026-02-26T16:47:01.161628Z","caller":"traceutil/trace.go:171","msg":"trace[1950395924] linearizableReadLoop","detail":"{readStateIndex:480; appliedIndex:479; }","duration":"145.815155ms","start":"2026-02-26T16:47:01.015796Z","end":"2026-02-26T16:47:01.161611Z","steps":["trace[1950395924] 'read index received'  (duration: 115.438942ms)","trace[1950395924] 'applied index is now lower than readState.Index'  (duration: 30.375553ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:47:01.161875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.05265ms","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-26T16:47:01.161988Z","caller":"traceutil/trace.go:171","msg":"trace[324161388] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:465; }","duration":"146.220305ms","start":"2026-02-26T16:47:01.015747Z","end":"2026-02-26T16:47:01.161968Z","steps":["trace[324161388] 'agreement among raft nodes before linearized reading'  (duration: 146.01531ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:47:01.162121Z","caller":"traceutil/trace.go:171","msg":"trace[1337584817] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"180.840528ms","start":"2026-02-26T16:47:00.981264Z","end":"2026-02-26T16:47:01.162104Z","steps":["trace[1337584817] 'process raft request'  (duration: 150.010074ms)","trace[1337584817] 'compare'  (duration: 30.267441ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:47:06.653547Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255400287937919,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-26T16:47:06.663744Z","caller":"traceutil/trace.go:171","msg":"trace[1562009555] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"544.635764ms","start":"2026-02-26T16:47:06.119087Z","end":"2026-02-26T16:47:06.663723Z","steps":["trace[1562009555] 'process raft request'  (duration: 544.535532ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:06.664119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:06.119063Z","time spent":"544.727136ms","remote":"127.0.0.1:48288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" value_size:4142 >> failure:<>"}
{"level":"info","ts":"2026-02-26T16:47:06.691364Z","caller":"traceutil/trace.go:171","msg":"trace[13989526] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:554; }","duration":"538.690805ms","start":"2026-02-26T16:47:06.152645Z","end":"2026-02-26T16:47:06.691336Z","steps":["trace[13989526] 'read index received'  (duration: 511.056365ms)","trace[13989526] 'applied index is now lower than readState.Index'  (duration: 27.63351ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:47:06.69148Z","caller":"traceutil/trace.go:171","msg":"trace[1783328445] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"372.110872ms","start":"2026-02-26T16:47:06.319356Z","end":"2026-02-26T16:47:06.691467Z","steps":["trace[1783328445] 'process raft request'  (duration: 371.880017ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:06.691564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:06.319332Z","time spent":"372.174963ms","remote":"127.0.0.1:48288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" value_size:3262 >> failure:<>"}
{"level":"warn","ts":"2026-02-26T16:47:06.691638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.954901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:47:06.691722Z","caller":"traceutil/trace.go:171","msg":"trace[1231039546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:540; }","duration":"539.099424ms","start":"2026-02-26T16:47:06.152603Z","end":"2026-02-26T16:47:06.691702Z","steps":["trace[1231039546] 'agreement among raft nodes before linearized reading'  (duration: 538.90471ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:06.691772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:06.152583Z","time spent":"539.181776ms","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-26T16:47:06.693947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.675701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:47:06.69401Z","caller":"traceutil/trace.go:171","msg":"trace[1895841753] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:541; }","duration":"176.774613ms","start":"2026-02-26T16:47:06.51722Z","end":"2026-02-26T16:47:06.693994Z","steps":["trace[1895841753] 'agreement among raft nodes before linearized reading'  (duration: 176.674101ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:09.218176Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255400287937953,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-26T16:47:09.446993Z","caller":"traceutil/trace.go:171","msg":"trace[1059028041] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:576; }","duration":"728.867203ms","start":"2026-02-26T16:47:08.718064Z","end":"2026-02-26T16:47:09.446931Z","steps":["trace[1059028041] 'read index received'  (duration: 723.362104ms)","trace[1059028041] 'applied index is now lower than readState.Index'  (duration: 5.504169ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:47:09.447054Z","caller":"traceutil/trace.go:171","msg":"trace[868493693] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"796.499442ms","start":"2026-02-26T16:47:08.650516Z","end":"2026-02-26T16:47:09.447016Z","steps":["trace[868493693] 'process raft request'  (duration: 791.125866ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:09.447283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.19522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"}
{"level":"warn","ts":"2026-02-26T16:47:09.44737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:08.650491Z","time spent":"796.628295ms","remote":"127.0.0.1:48288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" mod_revision:560 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" value_size:188130 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" > >"}
{"level":"info","ts":"2026-02-26T16:47:09.447336Z","caller":"traceutil/trace.go:171","msg":"trace[1976606214] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:561; }","duration":"729.308183ms","start":"2026-02-26T16:47:08.718012Z","end":"2026-02-26T16:47:09.44732Z","steps":["trace[1976606214] 'agreement among raft nodes before linearized reading'  (duration: 729.111668ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:09.447439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.79004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.12\" ","response":"range_response_count:1 size:133"}
{"level":"warn","ts":"2026-02-26T16:47:09.447468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:08.717996Z","time spent":"729.458356ms","remote":"127.0.0.1:48288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5200,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "}
{"level":"info","ts":"2026-02-26T16:47:09.447488Z","caller":"traceutil/trace.go:171","msg":"trace[884128354] range","detail":"{range_begin:/registry/masterleases/162.253.55.12; range_end:; response_count:1; response_revision:561; }","duration":"576.864742ms","start":"2026-02-26T16:47:08.870608Z","end":"2026-02-26T16:47:09.447473Z","steps":["trace[884128354] 'agreement among raft nodes before linearized reading'  (duration: 576.77623ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:09.447512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:08.870594Z","time spent":"576.913633ms","remote":"127.0.0.1:48270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.12\" "}
{"level":"warn","ts":"2026-02-26T16:47:09.447549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.032741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:47:09.447577Z","caller":"traceutil/trace.go:171","msg":"trace[1203471339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"295.107123ms","start":"2026-02-26T16:47:09.152462Z","end":"2026-02-26T16:47:09.447569Z","steps":["trace[1203471339] 'agreement among raft nodes before linearized reading'  (duration: 295.056571ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:09.447645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.030133ms","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-26T16:47:09.447662Z","caller":"traceutil/trace.go:171","msg":"trace[1418338908] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:561; }","duration":"304.086485ms","start":"2026-02-26T16:47:09.14357Z","end":"2026-02-26T16:47:09.447657Z","steps":["trace[1418338908] 'agreement among raft nodes before linearized reading'  (duration: 304.026973ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:09.447676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:09.143539Z","time spent":"304.133485ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-26T16:47:09.447725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.673102ms","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-26T16:47:09.447746Z","caller":"traceutil/trace.go:171","msg":"trace[1869789415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:561; }","duration":"248.741294ms","start":"2026-02-26T16:47:09.198999Z","end":"2026-02-26T16:47:09.44774Z","steps":["trace[1869789415] 'agreement among raft nodes before linearized reading'  (duration: 248.660372ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:09.447714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.335478ms","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-26T16:47:09.447773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.669015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"}
{"level":"info","ts":"2026-02-26T16:47:09.447792Z","caller":"traceutil/trace.go:171","msg":"trace[833697017] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:561; }","duration":"329.756047ms","start":"2026-02-26T16:47:09.118028Z","end":"2026-02-26T16:47:09.447784Z","steps":["trace[833697017] 'agreement among raft nodes before linearized reading'  (duration: 329.709146ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:09.447806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:09.11801Z","time spent":"329.792488ms","remote":"127.0.0.1:48288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10400,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "}
{"level":"info","ts":"2026-02-26T16:47:09.447793Z","caller":"traceutil/trace.go:171","msg":"trace[1442266795] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:561; }","duration":"229.476271ms","start":"2026-02-26T16:47:09.218296Z","end":"2026-02-26T16:47:09.447772Z","steps":["trace[1442266795] 'agreement among raft nodes before linearized reading'  (duration: 229.255726ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:09.447933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.820967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"}
{"level":"info","ts":"2026-02-26T16:47:09.447973Z","caller":"traceutil/trace.go:171","msg":"trace[1861399028] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:561; }","duration":"529.859548ms","start":"2026-02-26T16:47:08.918102Z","end":"2026-02-26T16:47:09.447961Z","steps":["trace[1861399028] 'agreement among raft nodes before linearized reading'  (duration: 529.750345ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:09.448004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:08.918059Z","time spent":"529.93763ms","remote":"127.0.0.1:48288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4356,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "}
{"level":"warn","ts":"2026-02-26T16:47:09.44811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.977163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"}
{"level":"info","ts":"2026-02-26T16:47:09.448156Z","caller":"traceutil/trace.go:171","msg":"trace[1597416567] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:561; }","duration":"130.043725ms","start":"2026-02-26T16:47:09.318099Z","end":"2026-02-26T16:47:09.448142Z","steps":["trace[1597416567] 'agreement among raft nodes before linearized reading'  (duration: 129.83329ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:47:13.585424Z","caller":"traceutil/trace.go:171","msg":"trace[1529525367] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:596; }","duration":"100.592504ms","start":"2026-02-26T16:47:13.484817Z","end":"2026-02-26T16:47:13.58541Z","steps":["trace[1529525367] 'read index received'  (duration: 70.302222ms)","trace[1529525367] 'applied index is now lower than readState.Index'  (duration: 30.289602ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:47:13.585515Z","caller":"traceutil/trace.go:171","msg":"trace[1394916351] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"114.839648ms","start":"2026-02-26T16:47:13.470667Z","end":"2026-02-26T16:47:13.585507Z","steps":["trace[1394916351] 'process raft request'  (duration: 114.622143ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:13.585773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.938901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-26T16:47:13.585906Z","caller":"traceutil/trace.go:171","msg":"trace[989176357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"101.110526ms","start":"2026-02-26T16:47:13.484777Z","end":"2026-02-26T16:47:13.585887Z","steps":["trace[989176357] 'agreement among raft nodes before linearized reading'  (duration: 100.826549ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:47:13.586178Z","caller":"traceutil/trace.go:171","msg":"trace[799513731] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"114.865168ms","start":"2026-02-26T16:47:13.471296Z","end":"2026-02-26T16:47:13.586161Z","steps":["trace[799513731] 'process raft request'  (duration: 114.08739ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:47:14.656694Z","caller":"traceutil/trace.go:171","msg":"trace[1008938769] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"223.323306ms","start":"2026-02-26T16:47:14.433336Z","end":"2026-02-26T16:47:14.656659Z","steps":["trace[1008938769] 'read index received'  (duration: 201.776591ms)","trace[1008938769] 'applied index is now lower than readState.Index'  (duration: 21.544765ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:47:14.656894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.543812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:47:14.657003Z","caller":"traceutil/trace.go:171","msg":"trace[1776383695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"223.704955ms","start":"2026-02-26T16:47:14.433275Z","end":"2026-02-26T16:47:14.65698Z","steps":["trace[1776383695] 'agreement among raft nodes before linearized reading'  (duration: 223.513281ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:47:34.055969Z","caller":"traceutil/trace.go:171","msg":"trace[802260086] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"391.447005ms","start":"2026-02-26T16:47:33.6645Z","end":"2026-02-26T16:47:34.055947Z","steps":["trace[802260086] 'process raft request'  (duration: 391.332522ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:34.056113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:33.664476Z","time spent":"391.564037ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:719 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-26T16:47:34.056273Z","caller":"traceutil/trace.go:171","msg":"trace[613592411] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:748; }","duration":"339.755371ms","start":"2026-02-26T16:47:33.716486Z","end":"2026-02-26T16:47:34.056242Z","steps":["trace[613592411] 'read index received'  (duration: 339.746551ms)","trace[613592411] 'applied index is now lower than readState.Index'  (duration: 6.76µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:47:34.056521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.007268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-02-26T16:47:34.056527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.580431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-26T16:47:34.056562Z","caller":"traceutil/trace.go:171","msg":"trace[1948592968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:725; }","duration":"314.660633ms","start":"2026-02-26T16:47:33.741888Z","end":"2026-02-26T16:47:34.056549Z","steps":["trace[1948592968] 'agreement among raft nodes before linearized reading'  (duration: 314.52678ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:47:34.056559Z","caller":"traceutil/trace.go:171","msg":"trace[880886299] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:725; }","duration":"340.07497ms","start":"2026-02-26T16:47:33.71647Z","end":"2026-02-26T16:47:34.056545Z","steps":["trace[880886299] 'agreement among raft nodes before linearized reading'  (duration: 339.898706ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:34.056584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:33.741857Z","time spent":"314.722364ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-26T16:47:34.056576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.422535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-02-26T16:47:34.056595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:33.716462Z","time spent":"340.124531ms","remote":"127.0.0.1:48506","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-26T16:47:34.05663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.227597ms","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-26T16:47:34.056644Z","caller":"traceutil/trace.go:171","msg":"trace[1653222126] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:725; }","duration":"339.519947ms","start":"2026-02-26T16:47:33.717106Z","end":"2026-02-26T16:47:34.056626Z","steps":["trace[1653222126] 'agreement among raft nodes before linearized reading'  (duration: 339.297942ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:47:34.056684Z","caller":"traceutil/trace.go:171","msg":"trace[271838725] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:725; }","duration":"327.33918ms","start":"2026-02-26T16:47:33.72933Z","end":"2026-02-26T16:47:34.05667Z","steps":["trace[271838725] 'agreement among raft nodes before linearized reading'  (duration: 327.121175ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:34.056705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:33.7171Z","time spent":"339.597438ms","remote":"127.0.0.1:48506","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-26T16:47:34.056721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:33.729302Z","time spent":"327.410862ms","remote":"127.0.0.1:48506","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-26T16:47:34.674771Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255400287938311,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-26T16:47:35.175516Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255400287938311,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-26T16:47:35.903986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.526654013s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:47:35.904096Z","caller":"traceutil/trace.go:171","msg":"trace[2115701102] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:725; }","duration":"1.526776886s","start":"2026-02-26T16:47:34.377303Z","end":"2026-02-26T16:47:35.90408Z","steps":["trace[2115701102] 'range keys from in-memory index tree'  (duration: 1.526638343s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:35.904625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.045337ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287938312 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:721 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T16:47:35.90471Z","caller":"traceutil/trace.go:171","msg":"trace[276223664] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"1.844138701s","start":"2026-02-26T16:47:34.060557Z","end":"2026-02-26T16:47:35.904696Z","steps":["trace[276223664] 'process raft request'  (duration: 1.400794067s)","trace[276223664] 'compare'  (duration: 442.954355ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:47:35.904767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:34.060533Z","time spent":"1.844204853s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:721 > 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-26T16:47:36.112755Z","caller":"traceutil/trace.go:171","msg":"trace[182403999] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"2.051956345s","start":"2026-02-26T16:47:34.060783Z","end":"2026-02-26T16:47:36.11274Z","steps":["trace[182403999] 'process raft request'  (duration: 2.051901053s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:36.112861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:34.060776Z","time spent":"2.052029086s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:720 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-26T16:47:36.112927Z","caller":"traceutil/trace.go:171","msg":"trace[2033930616] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"2.05222641s","start":"2026-02-26T16:47:34.060677Z","end":"2026-02-26T16:47:36.112903Z","steps":["trace[2033930616] 'process raft request'  (duration: 2.051905913s)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:47:36.113007Z","caller":"traceutil/trace.go:171","msg":"trace[598893990] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"2.051100285s","start":"2026-02-26T16:47:34.061899Z","end":"2026-02-26T16:47:36.113Z","steps":["trace[598893990] 'process raft request'  (duration: 2.050810948s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:36.113043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:34.060642Z","time spent":"2.052333003s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:724 > 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-26T16:47:36.113048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:34.061881Z","time spent":"2.051144585s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:723 > 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-26T16:47:36.174138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999948021s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-26T16:47:36.174267Z","caller":"traceutil/trace.go:171","msg":"trace[731535207] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000126996s","start":"2026-02-26T16:47:34.174115Z","end":"2026-02-26T16:47:36.174242Z","steps":["trace[731535207] 'agreement among raft nodes before linearized reading'  (duration: 1.999965242s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:36.174322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:34.174099Z","time spent":"2.000210888s","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-26T16:47:36.174317Z","caller":"traceutil/trace.go:171","msg":"trace[1971029642] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:748; }","duration":"2.000146037s","start":"2026-02-26T16:47:34.174152Z","end":"2026-02-26T16:47:36.174298Z","steps":["trace[1971029642] 'read index received'  (duration: 1.287211778s)","trace[1971029642] 'applied index is now lower than readState.Index'  (duration: 712.933409ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:47:36.174382Z","caller":"traceutil/trace.go:171","msg":"trace[1915956291] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"753.971653ms","start":"2026-02-26T16:47:35.420383Z","end":"2026-02-26T16:47:36.174354Z","steps":["trace[1915956291] 'process raft request'  (duration: 753.786439ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:36.174456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:35.420361Z","time spent":"754.062726ms","remote":"127.0.0.1:48318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":811,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/coredns-7c96b6546b-4lfqg.1897d9cd96f27bad\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-7c96b6546b-4lfqg.1897d9cd96f27bad\" value_size:723 lease:4092255400287936980 >> failure:<>"}
{"level":"warn","ts":"2026-02-26T16:47:36.174613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.826425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-26T16:47:36.174666Z","caller":"traceutil/trace.go:171","msg":"trace[1085368334] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:730; }","duration":"113.909256ms","start":"2026-02-26T16:47:36.060742Z","end":"2026-02-26T16:47:36.174651Z","steps":["trace[1085368334] 'agreement among raft nodes before linearized reading'  (duration: 113.712211ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:47:36.488472Z","caller":"traceutil/trace.go:171","msg":"trace[2027030274] linearizableReadLoop","detail":"{readStateIndex:756; appliedIndex:754; }","duration":"306.310137ms","start":"2026-02-26T16:47:36.182141Z","end":"2026-02-26T16:47:36.488451Z","steps":["trace[2027030274] 'read index received'  (duration: 222.548159ms)","trace[2027030274] 'applied index is now lower than readState.Index'  (duration: 83.761168ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:47:36.488503Z","caller":"traceutil/trace.go:171","msg":"trace[109831509] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"310.260639ms","start":"2026-02-26T16:47:36.178224Z","end":"2026-02-26T16:47:36.488485Z","steps":["trace[109831509] 'process raft request'  (duration: 226.307227ms)","trace[109831509] 'compare'  (duration: 83.565583ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:47:36.488507Z","caller":"traceutil/trace.go:171","msg":"trace[264847431] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"310.102256ms","start":"2026-02-26T16:47:36.17839Z","end":"2026-02-26T16:47:36.488492Z","steps":["trace[264847431] 'process raft request'  (duration: 309.987353ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:36.488603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:36.178201Z","time spent":"310.350451ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:725 > 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-26T16:47:36.488609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.45789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-26T16:47:36.488621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:36.178364Z","time spent":"310.195367ms","remote":"127.0.0.1:48318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.1897d9cdc42658f7\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.1897d9cdc42658f7\" value_size:672 lease:4092255400287936980 >> failure:<>"}
{"level":"info","ts":"2026-02-26T16:47:36.488643Z","caller":"traceutil/trace.go:171","msg":"trace[1362752202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:732; }","duration":"306.522732ms","start":"2026-02-26T16:47:36.182111Z","end":"2026-02-26T16:47:36.488634Z","steps":["trace[1362752202] 'agreement among raft nodes before linearized reading'  (duration: 306.43334ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:47:36.488668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:47:36.182094Z","time spent":"306.567443ms","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-26T16:47:38.051984Z","caller":"traceutil/trace.go:171","msg":"trace[3619526] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"139.713452ms","start":"2026-02-26T16:47:37.912239Z","end":"2026-02-26T16:47:38.051953Z","steps":["trace[3619526] 'process raft request'  (duration: 139.474787ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:47:38.307881Z","caller":"traceutil/trace.go:171","msg":"trace[1453556352] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"111.345056ms","start":"2026-02-26T16:47:38.196512Z","end":"2026-02-26T16:47:38.307857Z","steps":["trace[1453556352] 'process raft request'  (duration: 12.957065ms)","trace[1453556352] 'compare'  (duration: 98.271678ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:47:50.323746Z","caller":"traceutil/trace.go:171","msg":"trace[571207520] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"104.506939ms","start":"2026-02-26T16:47:50.219221Z","end":"2026-02-26T16:47:50.323728Z","steps":["trace[571207520] 'process raft request'  (duration: 104.387766ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:00.945543Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255400287938514,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-26T16:48:01.006009Z","caller":"traceutil/trace.go:171","msg":"trace[1441658363] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:830; }","duration":"561.440781ms","start":"2026-02-26T16:48:00.444533Z","end":"2026-02-26T16:48:01.005974Z","steps":["trace[1441658363] 'read index received'  (duration: 561.129174ms)","trace[1441658363] 'applied index is now lower than readState.Index'  (duration: 310.387µs)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:48:01.006166Z","caller":"traceutil/trace.go:171","msg":"trace[786219549] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"592.965853ms","start":"2026-02-26T16:48:00.41315Z","end":"2026-02-26T16:48:01.006116Z","steps":["trace[786219549] 'process raft request'  (duration: 592.621886ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:01.006264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.705786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:01.006316Z","caller":"traceutil/trace.go:171","msg":"trace[1798948974] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:802; }","duration":"561.837209ms","start":"2026-02-26T16:48:00.444461Z","end":"2026-02-26T16:48:01.006299Z","steps":["trace[1798948974] 'agreement among raft nodes before linearized reading'  (duration: 561.725187ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:01.006359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:00.44443Z","time spent":"561.914431ms","remote":"127.0.0.1:48746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-02-26T16:48:01.006369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:00.41313Z","time spent":"593.125727ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:795 > 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-26T16:48:01.006597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.005436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-02-26T16:48:01.006562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.715449ms","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-26T16:48:01.006641Z","caller":"traceutil/trace.go:171","msg":"trace[706859581] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:802; }","duration":"533.070767ms","start":"2026-02-26T16:48:00.473557Z","end":"2026-02-26T16:48:01.006628Z","steps":["trace[706859581] 'agreement among raft nodes before linearized reading'  (duration: 532.924364ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:01.006675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:00.473546Z","time spent":"533.123128ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-26T16:48:01.00671Z","caller":"traceutil/trace.go:171","msg":"trace[1828305475] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:802; }","duration":"540.924232ms","start":"2026-02-26T16:48:00.465748Z","end":"2026-02-26T16:48:01.006672Z","steps":["trace[1828305475] 'agreement among raft nodes before linearized reading'  (duration: 540.506913ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:01.006583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.28425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-02-26T16:48:01.006747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.235134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-26T16:48:01.006789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:00.465728Z","time spent":"541.044636ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-26T16:48:01.006883Z","caller":"traceutil/trace.go:171","msg":"trace[2130572128] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:802; }","duration":"363.432798ms","start":"2026-02-26T16:48:00.64342Z","end":"2026-02-26T16:48:01.006853Z","steps":["trace[2130572128] 'agreement among raft nodes before linearized reading'  (duration: 363.03369ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:01.006942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:00.643398Z","time spent":"363.53381ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-26T16:48:01.006804Z","caller":"traceutil/trace.go:171","msg":"trace[1249669319] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:802; }","duration":"532.523666ms","start":"2026-02-26T16:48:00.474257Z","end":"2026-02-26T16:48:01.006781Z","steps":["trace[1249669319] 'agreement among raft nodes before linearized reading'  (duration: 532.139867ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:01.007093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:00.474244Z","time spent":"532.830222ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-26T16:48:02.814804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.422359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-26T16:48:02.814883Z","caller":"traceutil/trace.go:171","msg":"trace[930273548] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:807; }","duration":"232.649593ms","start":"2026-02-26T16:48:02.582215Z","end":"2026-02-26T16:48:02.814864Z","steps":["trace[930273548] 'count revisions from in-memory index tree'  (duration: 232.273906ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:03.453976Z","caller":"traceutil/trace.go:171","msg":"trace[735819111] linearizableReadLoop","detail":"{readStateIndex:837; appliedIndex:836; }","duration":"398.177603ms","start":"2026-02-26T16:48:03.055771Z","end":"2026-02-26T16:48:03.453948Z","steps":["trace[735819111] 'read index received'  (duration: 397.938637ms)","trace[735819111] 'applied index is now lower than readState.Index'  (duration: 238.006µs)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:48:03.454327Z","caller":"traceutil/trace.go:171","msg":"trace[1015138721] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"431.187268ms","start":"2026-02-26T16:48:03.023127Z","end":"2026-02-26T16:48:03.454314Z","steps":["trace[1015138721] 'process raft request'  (duration: 430.641165ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:03.454507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:03.023103Z","time spent":"431.2628ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:802 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-26T16:48:03.454842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.065413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-26T16:48:03.454886Z","caller":"traceutil/trace.go:171","msg":"trace[132518156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:808; }","duration":"399.153305ms","start":"2026-02-26T16:48:03.055722Z","end":"2026-02-26T16:48:03.454875Z","steps":["trace[132518156] 'agreement among raft nodes before linearized reading'  (duration: 399.005762ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:03.455156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.307808ms","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-26T16:48:03.455207Z","caller":"traceutil/trace.go:171","msg":"trace[1789112541] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:808; }","duration":"399.38329ms","start":"2026-02-26T16:48:03.055811Z","end":"2026-02-26T16:48:03.455195Z","steps":["trace[1789112541] 'agreement among raft nodes before linearized reading'  (duration: 399.263767ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:03.455239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:03.055799Z","time spent":"399.433381ms","remote":"127.0.0.1:48506","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-26T16:48:03.455449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.434282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:03.455485Z","caller":"traceutil/trace.go:171","msg":"trace[1041611131] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:808; }","duration":"295.498394ms","start":"2026-02-26T16:48:03.159978Z","end":"2026-02-26T16:48:03.455476Z","steps":["trace[1041611131] 'agreement among raft nodes before linearized reading'  (duration: 295.442393ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:03.454916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:03.0557Z","time spent":"399.209426ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-26T16:48:03.455755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.909638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-26T16:48:03.455792Z","caller":"traceutil/trace.go:171","msg":"trace[145226016] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:808; }","duration":"398.96773ms","start":"2026-02-26T16:48:03.056815Z","end":"2026-02-26T16:48:03.455783Z","steps":["trace[145226016] 'agreement among raft nodes before linearized reading'  (duration: 398.874688ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:03.45582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:03.056806Z","time spent":"399.00806ms","remote":"127.0.0.1:48506","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-26T16:48:03.456058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.958042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-26T16:48:03.456218Z","caller":"traceutil/trace.go:171","msg":"trace[1066531977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:808; }","duration":"400.179137ms","start":"2026-02-26T16:48:03.056002Z","end":"2026-02-26T16:48:03.456181Z","steps":["trace[1066531977] 'agreement among raft nodes before linearized reading'  (duration: 399.709557ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:03.456303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:03.05599Z","time spent":"400.29769ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-26T16:48:03.689762Z","caller":"traceutil/trace.go:171","msg":"trace[784832044] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"227.590092ms","start":"2026-02-26T16:48:03.46214Z","end":"2026-02-26T16:48:03.68973Z","steps":["trace[784832044] 'process raft request'  (duration: 227.49707ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:03.689803Z","caller":"traceutil/trace.go:171","msg":"trace[683902317] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"227.693424ms","start":"2026-02-26T16:48:03.46209Z","end":"2026-02-26T16:48:03.689783Z","steps":["trace[683902317] 'process raft request'  (duration: 218.701023ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:03.689963Z","caller":"traceutil/trace.go:171","msg":"trace[399362491] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"227.763315ms","start":"2026-02-26T16:48:03.462171Z","end":"2026-02-26T16:48:03.689935Z","steps":["trace[399362491] 'process raft request'  (duration: 227.51837ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:18.266276Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255400287938735,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-26T16:48:18.766487Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255400287938735,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-26T16:48:19.266703Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255400287938735,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-26T16:48:19.449621Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.684374521s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-26T16:48:19.450201Z","caller":"traceutil/trace.go:171","msg":"trace[495816397] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"1.684998416s","start":"2026-02-26T16:48:17.765179Z","end":"2026-02-26T16:48:19.450177Z","steps":["trace[495816397] 'process raft request'  (duration: 1.684824153s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:19.450324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:17.765161Z","time spent":"1.685079648s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:894 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-26T16:48:20.152516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000404674s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-26T16:48:20.152606Z","caller":"traceutil/trace.go:171","msg":"trace[662998988] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000544297s","start":"2026-02-26T16:48:18.152035Z","end":"2026-02-26T16:48:20.15258Z","steps":["trace[662998988] 'agreement among raft nodes before linearized reading'  (duration: 2.000437775s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:20.152659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:18.152011Z","time spent":"2.000633538s","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-26T16:48:20.663887Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.214017051s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-26T16:48:20.98118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.018593ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287938737 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:895 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T16:48:20.981339Z","caller":"traceutil/trace.go:171","msg":"trace[1428863205] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"3.213449503s","start":"2026-02-26T16:48:17.767866Z","end":"2026-02-26T16:48:20.981316Z","steps":["trace[1428863205] 'process raft request'  (duration: 2.896225305s)","trace[1428863205] 'compare'  (duration: 316.904541ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:20.98144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:17.767855Z","time spent":"3.213527844s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:895 > 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-26T16:48:20.981443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.215425357s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-26T16:48:20.981472Z","caller":"traceutil/trace.go:171","msg":"trace[1568621176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:901; }","duration":"3.215472548s","start":"2026-02-26T16:48:17.765987Z","end":"2026-02-26T16:48:20.98146Z","steps":["trace[1568621176] 'agreement among raft nodes before linearized reading'  (duration: 3.215331585s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:20.981506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:17.76598Z","time spent":"3.215521549s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-26T16:48:20.981552Z","caller":"traceutil/trace.go:171","msg":"trace[1564486677] linearizableReadLoop","detail":"{readStateIndex:934; appliedIndex:932; }","duration":"3.215311165s","start":"2026-02-26T16:48:17.766005Z","end":"2026-02-26T16:48:20.981316Z","steps":["trace[1564486677] 'read index received'  (duration: 1.683982514s)","trace[1564486677] 'applied index is now lower than readState.Index'  (duration: 1.531327601s)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:48:20.981595Z","caller":"traceutil/trace.go:171","msg":"trace[1628718592] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"1.635626666s","start":"2026-02-26T16:48:19.345947Z","end":"2026-02-26T16:48:20.981573Z","steps":["trace[1628718592] 'process raft request'  (duration: 1.635304108s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:20.981632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.081653936s","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-26T16:48:20.981651Z","caller":"traceutil/trace.go:171","msg":"trace[2045438472] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:901; }","duration":"3.081709557s","start":"2026-02-26T16:48:17.899936Z","end":"2026-02-26T16:48:20.981645Z","steps":["trace[2045438472] 'agreement among raft nodes before linearized reading'  (duration: 3.081671256s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:20.981667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:17.899919Z","time spent":"3.081744297s","remote":"127.0.0.1:48440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"warn","ts":"2026-02-26T16:48:20.981713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:19.345926Z","time spent":"1.635713897s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:824 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-26T16:48:20.981699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.586240295s","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":"warn","ts":"2026-02-26T16:48:20.981737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.668358264s","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-26T16:48:20.981755Z","caller":"traceutil/trace.go:171","msg":"trace[908045800] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:901; }","duration":"1.668442616s","start":"2026-02-26T16:48:19.313308Z","end":"2026-02-26T16:48:20.98175Z","steps":["trace[908045800] 'agreement among raft nodes before linearized reading'  (duration: 1.668408086s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:20.981768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:19.313283Z","time spent":"1.668481967s","remote":"127.0.0.1:48420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "}
{"level":"info","ts":"2026-02-26T16:48:20.981762Z","caller":"traceutil/trace.go:171","msg":"trace[444830149] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:901; }","duration":"1.586323236s","start":"2026-02-26T16:48:19.395424Z","end":"2026-02-26T16:48:20.981748Z","steps":["trace[444830149] 'agreement among raft nodes before linearized reading'  (duration: 1.586193993s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:20.981797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:19.395375Z","time spent":"1.586414938s","remote":"127.0.0.1:48714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "}
{"level":"warn","ts":"2026-02-26T16:48:20.981852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.01058177s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-26T16:48:20.981866Z","caller":"traceutil/trace.go:171","msg":"trace[726795756] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:901; }","duration":"2.01062464s","start":"2026-02-26T16:48:18.971237Z","end":"2026-02-26T16:48:20.981862Z","steps":["trace[726795756] 'agreement among raft nodes before linearized reading'  (duration: 2.010599109s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:20.981881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:18.971217Z","time spent":"2.010660001s","remote":"127.0.0.1:48640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":30,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "}
{"level":"warn","ts":"2026-02-26T16:48:20.981909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.787926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:20.981932Z","caller":"traceutil/trace.go:171","msg":"trace[615003841] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:901; }","duration":"828.848967ms","start":"2026-02-26T16:48:20.153077Z","end":"2026-02-26T16:48:20.981926Z","steps":["trace[615003841] 'agreement among raft nodes before linearized reading'  (duration: 828.810606ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:20.981949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:20.153055Z","time spent":"828.890559ms","remote":"127.0.0.1:48252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-26T16:48:20.982012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.107391207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.12\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-26T16:48:20.982059Z","caller":"traceutil/trace.go:171","msg":"trace[1313895153] range","detail":"{range_begin:/registry/masterleases/162.253.55.12; range_end:; response_count:1; response_revision:901; }","duration":"2.107478669s","start":"2026-02-26T16:48:18.874575Z","end":"2026-02-26T16:48:20.982054Z","steps":["trace[1313895153] 'agreement among raft nodes before linearized reading'  (duration: 2.107371157s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:20.982075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:18.874552Z","time spent":"2.107518909s","remote":"127.0.0.1:48270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.12\" "}
{"level":"warn","ts":"2026-02-26T16:48:20.982111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.39393383s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-26T16:48:20.982114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.529880871s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:20.982186Z","caller":"traceutil/trace.go:171","msg":"trace[818483119] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:901; }","duration":"2.530020475s","start":"2026-02-26T16:48:18.45215Z","end":"2026-02-26T16:48:20.98217Z","steps":["trace[818483119] 'agreement among raft nodes before linearized reading'  (duration: 2.52983834s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:20.982226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:18.452127Z","time spent":"2.530090147s","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "}
{"level":"warn","ts":"2026-02-26T16:48:20.982939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.448822223s","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-26T16:48:20.983039Z","caller":"traceutil/trace.go:171","msg":"trace[823035509] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:901; }","duration":"1.448938615s","start":"2026-02-26T16:48:19.534072Z","end":"2026-02-26T16:48:20.983011Z","steps":["trace[823035509] 'agreement among raft nodes before linearized reading'  (duration: 1.448087576s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:20.983087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:19.534055Z","time spent":"1.449019837s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-26T16:48:20.98214Z","caller":"traceutil/trace.go:171","msg":"trace[1028471683] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:901; }","duration":"1.393994902s","start":"2026-02-26T16:48:19.588137Z","end":"2026-02-26T16:48:20.982132Z","steps":["trace[1028471683] 'agreement among raft nodes before linearized reading'  (duration: 1.393835907s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:20.983145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:19.588118Z","time spent":"1.395009694s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-26T16:48:23.298782Z","caller":"traceutil/trace.go:171","msg":"trace[554049093] linearizableReadLoop","detail":"{readStateIndex:947; appliedIndex:946; }","duration":"116.819262ms","start":"2026-02-26T16:48:23.181936Z","end":"2026-02-26T16:48:23.298755Z","steps":["trace[554049093] 'read index received'  (duration: 33.028116ms)","trace[554049093] 'applied index is now lower than readState.Index'  (duration: 83.789946ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:23.298912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.948606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:23.298947Z","caller":"traceutil/trace.go:171","msg":"trace[66757074] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:912; }","duration":"117.031448ms","start":"2026-02-26T16:48:23.181903Z","end":"2026-02-26T16:48:23.298934Z","steps":["trace[66757074] 'agreement among raft nodes before linearized reading'  (duration: 116.944356ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:23.298985Z","caller":"traceutil/trace.go:171","msg":"trace[734398907] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"145.084903ms","start":"2026-02-26T16:48:23.153854Z","end":"2026-02-26T16:48:23.298939Z","steps":["trace[734398907] 'process raft request'  (duration: 61.075791ms)","trace[734398907] 'compare'  (duration: 83.701034ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:48:33.654318Z","caller":"traceutil/trace.go:171","msg":"trace[1619587049] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"220.33053ms","start":"2026-02-26T16:48:33.433959Z","end":"2026-02-26T16:48:33.65429Z","steps":["trace[1619587049] 'process raft request'  (duration: 220.179916ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:33.937191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.144387ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287938852 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:935 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T16:48:33.93743Z","caller":"traceutil/trace.go:171","msg":"trace[1441835446] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"278.29355ms","start":"2026-02-26T16:48:33.659075Z","end":"2026-02-26T16:48:33.937369Z","steps":["trace[1441835446] 'process raft request'  (duration: 91.867357ms)","trace[1441835446] 'compare'  (duration: 185.601325ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:34.378899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.351882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:34.378953Z","caller":"traceutil/trace.go:171","msg":"trace[1376138354] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:941; }","duration":"225.455944ms","start":"2026-02-26T16:48:34.153484Z","end":"2026-02-26T16:48:34.378939Z","steps":["trace[1376138354] 'range keys from in-memory index tree'  (duration: 225.230609ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:34.379004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.215446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-26T16:48:34.379097Z","caller":"traceutil/trace.go:171","msg":"trace[646584169] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:941; }","duration":"303.323798ms","start":"2026-02-26T16:48:34.075747Z","end":"2026-02-26T16:48:34.379071Z","steps":["trace[646584169] 'count revisions from in-memory index tree'  (duration: 303.126934ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:34.379513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:34.075723Z","time spent":"303.417231ms","remote":"127.0.0.1:48624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "}
{"level":"info","ts":"2026-02-26T16:48:35.403584Z","caller":"traceutil/trace.go:171","msg":"trace[1073169743] linearizableReadLoop","detail":"{readStateIndex:979; appliedIndex:978; }","duration":"184.119963ms","start":"2026-02-26T16:48:35.219439Z","end":"2026-02-26T16:48:35.403559Z","steps":["trace[1073169743] 'read index received'  (duration: 183.895607ms)","trace[1073169743] 'applied index is now lower than readState.Index'  (duration: 223.425µs)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:48:35.403656Z","caller":"traceutil/trace.go:171","msg":"trace[698287468] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"287.010745ms","start":"2026-02-26T16:48:35.116613Z","end":"2026-02-26T16:48:35.403623Z","steps":["trace[698287468] 'process raft request'  (duration: 286.772639ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:35.403934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.180741ms","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-26T16:48:35.403973Z","caller":"traceutil/trace.go:171","msg":"trace[712925029] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:942; }","duration":"165.241612ms","start":"2026-02-26T16:48:35.238721Z","end":"2026-02-26T16:48:35.403963Z","steps":["trace[712925029] 'agreement among raft nodes before linearized reading'  (duration: 165.15388ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:35.403965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.187477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-02-26T16:48:35.404064Z","caller":"traceutil/trace.go:171","msg":"trace[1318196374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:942; }","duration":"168.331641ms","start":"2026-02-26T16:48:35.23571Z","end":"2026-02-26T16:48:35.404042Z","steps":["trace[1318196374] 'agreement among raft nodes before linearized reading'  (duration: 168.083465ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:35.403836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.372338ms","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-26T16:48:35.404323Z","caller":"traceutil/trace.go:171","msg":"trace[1181705926] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:942; }","duration":"184.90449ms","start":"2026-02-26T16:48:35.219402Z","end":"2026-02-26T16:48:35.404306Z","steps":["trace[1181705926] 'agreement among raft nodes before linearized reading'  (duration: 184.306277ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:35.924902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.358443ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287938860 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:937 > 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-26T16:48:35.925212Z","caller":"traceutil/trace.go:171","msg":"trace[2039769984] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:979; }","duration":"169.030187ms","start":"2026-02-26T16:48:35.756163Z","end":"2026-02-26T16:48:35.925193Z","steps":["trace[2039769984] 'read index received'  (duration: 168.079305ms)","trace[2039769984] 'applied index is now lower than readState.Index'  (duration: 949.902µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:35.925295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.122029ms","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-26T16:48:35.925329Z","caller":"traceutil/trace.go:171","msg":"trace[687342237] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:945; }","duration":"169.1617ms","start":"2026-02-26T16:48:35.756158Z","end":"2026-02-26T16:48:35.92532Z","steps":["trace[687342237] 'agreement among raft nodes before linearized reading'  (duration: 169.099928ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:35.925327Z","caller":"traceutil/trace.go:171","msg":"trace[2031399244] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"515.21324ms","start":"2026-02-26T16:48:35.410092Z","end":"2026-02-26T16:48:35.925305Z","steps":["trace[2031399244] 'process raft request'  (duration: 514.904564ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:35.925371Z","caller":"traceutil/trace.go:171","msg":"trace[655303141] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"513.316057ms","start":"2026-02-26T16:48:35.412037Z","end":"2026-02-26T16:48:35.925353Z","steps":["trace[655303141] 'process raft request'  (duration: 513.122053ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:35.925367Z","caller":"traceutil/trace.go:171","msg":"trace[1538843754] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"515.625319ms","start":"2026-02-26T16:48:35.409713Z","end":"2026-02-26T16:48:35.925338Z","steps":["trace[1538843754] 'process raft request'  (duration: 258.753865ms)","trace[1538843754] 'compare'  (duration: 256.24895ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:35.925433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:35.410075Z","time spent":"515.298922ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:938 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-26T16:48:35.925459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:35.412014Z","time spent":"513.39738ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:939 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-26T16:48:35.925499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:35.409682Z","time spent":"515.746822ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:937 > 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-26T16:48:36.116454Z","caller":"traceutil/trace.go:171","msg":"trace[1788516590] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"172.386581ms","start":"2026-02-26T16:48:35.944042Z","end":"2026-02-26T16:48:36.116429Z","steps":["trace[1788516590] 'process raft request'  (duration: 121.924047ms)","trace[1788516590] 'compare'  (duration: 50.354392ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:37.043866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.218814ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287938869 > lease_revoke:<id:38ca9c9ad85628b5>","response":"size:28"}
{"level":"info","ts":"2026-02-26T16:48:37.043946Z","caller":"traceutil/trace.go:171","msg":"trace[1222640635] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:983; }","duration":"550.983357ms","start":"2026-02-26T16:48:36.49295Z","end":"2026-02-26T16:48:37.043934Z","steps":["trace[1222640635] 'read index received'  (duration: 42.961µs)","trace[1222640635] 'applied index is now lower than readState.Index'  (duration: 550.939336ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:37.044005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.0597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-26T16:48:37.044023Z","caller":"traceutil/trace.go:171","msg":"trace[598618793] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:946; }","duration":"551.130841ms","start":"2026-02-26T16:48:36.492887Z","end":"2026-02-26T16:48:37.044017Z","steps":["trace[598618793] 'agreement among raft nodes before linearized reading'  (duration: 551.07999ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:37.044049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:36.492865Z","time spent":"551.178232ms","remote":"127.0.0.1:48436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"info","ts":"2026-02-26T16:48:37.567336Z","caller":"traceutil/trace.go:171","msg":"trace[588754082] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"154.533853ms","start":"2026-02-26T16:48:37.412782Z","end":"2026-02-26T16:48:37.567316Z","steps":["trace[588754082] 'process raft request'  (duration: 154.3976ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:38.585668Z","caller":"traceutil/trace.go:171","msg":"trace[226790425] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"647.091268ms","start":"2026-02-26T16:48:37.938553Z","end":"2026-02-26T16:48:38.585644Z","steps":["trace[226790425] 'process raft request'  (duration: 646.918165ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:38.585827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:37.938543Z","time spent":"647.19456ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:943 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-26T16:48:39.707549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.257967ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287938879 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:944 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T16:48:39.707766Z","caller":"traceutil/trace.go:171","msg":"trace[1683502067] linearizableReadLoop","detail":"{readStateIndex:988; appliedIndex:985; }","duration":"1.587233857s","start":"2026-02-26T16:48:38.120516Z","end":"2026-02-26T16:48:39.70775Z","steps":["trace[1683502067] 'read index received'  (duration: 464.941339ms)","trace[1683502067] 'applied index is now lower than readState.Index'  (duration: 1.122291658s)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:48:39.707853Z","caller":"traceutil/trace.go:171","msg":"trace[785448692] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"1.76866657s","start":"2026-02-26T16:48:37.939178Z","end":"2026-02-26T16:48:39.707844Z","steps":["trace[785448692] 'process raft request'  (duration: 1.768494246s)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:39.707949Z","caller":"traceutil/trace.go:171","msg":"trace[1093523966] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"1.769278923s","start":"2026-02-26T16:48:37.938648Z","end":"2026-02-26T16:48:39.707927Z","steps":["trace[1093523966] 'process raft request'  (duration: 1.325538476s)","trace[1093523966] 'compare'  (duration: 443.004601ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:39.708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:37.939158Z","time spent":"1.768796572s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:945 > 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-26T16:48:39.708006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.558536287s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-26T16:48:39.708056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:37.938433Z","time spent":"1.76956209s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:944 > 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-26T16:48:39.708047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.017611ms","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-26T16:48:39.708075Z","caller":"traceutil/trace.go:171","msg":"trace[1863420803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:950; }","duration":"1.55867075s","start":"2026-02-26T16:48:38.149385Z","end":"2026-02-26T16:48:39.708056Z","steps":["trace[1863420803] 'agreement among raft nodes before linearized reading'  (duration: 1.558506097s)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:39.708104Z","caller":"traceutil/trace.go:171","msg":"trace[650434818] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:950; }","duration":"136.119673ms","start":"2026-02-26T16:48:39.571968Z","end":"2026-02-26T16:48:39.708088Z","steps":["trace[650434818] 'agreement among raft nodes before linearized reading'  (duration: 135.96789ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:39.708116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:38.149353Z","time spent":"1.558754981s","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-26T16:48:39.70819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.199773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.12\" ","response":"range_response_count:1 size:133"}
{"level":"warn","ts":"2026-02-26T16:48:39.708186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.587672957s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-26T16:48:39.708212Z","caller":"traceutil/trace.go:171","msg":"trace[688144451] range","detail":"{range_begin:/registry/masterleases/162.253.55.12; range_end:; response_count:1; response_revision:950; }","duration":"832.256484ms","start":"2026-02-26T16:48:38.87595Z","end":"2026-02-26T16:48:39.708207Z","steps":["trace[688144451] 'agreement among raft nodes before linearized reading'  (duration: 832.178612ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:39.708239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:38.875923Z","time spent":"832.312145ms","remote":"127.0.0.1:48270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.12\" "}
{"level":"info","ts":"2026-02-26T16:48:39.70825Z","caller":"traceutil/trace.go:171","msg":"trace[1677815589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:950; }","duration":"1.587758189s","start":"2026-02-26T16:48:38.120463Z","end":"2026-02-26T16:48:39.708222Z","steps":["trace[1677815589] 'agreement among raft nodes before linearized reading'  (duration: 1.587630306s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:39.708287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:38.120429Z","time spent":"1.5878492s","remote":"127.0.0.1:48506","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-26T16:48:40.097699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.811773ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287938888 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.12\" mod_revision:924 > success:<request_put:<key:\"/registry/masterleases/162.253.55.12\" value_size:66 lease:4092255400287938884 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.12\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T16:48:40.097784Z","caller":"traceutil/trace.go:171","msg":"trace[309871308] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"373.607724ms","start":"2026-02-26T16:48:39.724164Z","end":"2026-02-26T16:48:40.097771Z","steps":["trace[309871308] 'process raft request'  (duration: 120.669748ms)","trace[309871308] 'compare'  (duration: 252.740472ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:40.097824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:39.724144Z","time spent":"373.660886ms","remote":"127.0.0.1:48270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.12\" mod_revision:924 > success:<request_put:<key:\"/registry/masterleases/162.253.55.12\" value_size:66 lease:4092255400287938884 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.12\" > >"}
{"level":"warn","ts":"2026-02-26T16:48:40.572793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.838119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-26T16:48:40.572879Z","caller":"traceutil/trace.go:171","msg":"trace[426773240] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:954; }","duration":"210.957161ms","start":"2026-02-26T16:48:40.3619Z","end":"2026-02-26T16:48:40.572857Z","steps":["trace[426773240] 'count revisions from in-memory index tree'  (duration: 210.781338ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:41.269951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.753462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:41.270063Z","caller":"traceutil/trace.go:171","msg":"trace[1966206936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:955; }","duration":"116.872794ms","start":"2026-02-26T16:48:41.153143Z","end":"2026-02-26T16:48:41.270015Z","steps":["trace[1966206936] 'range keys from in-memory index tree'  (duration: 116.692141ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:42.285605Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255400287938901,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-26T16:48:42.786716Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255400287938901,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-26T16:48:43.251834Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.534330139s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-26T16:48:43.252209Z","caller":"traceutil/trace.go:171","msg":"trace[1074601765] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"1.534766798s","start":"2026-02-26T16:48:41.717417Z","end":"2026-02-26T16:48:43.252183Z","steps":["trace[1074601765] 'process raft request'  (duration: 1.534628015s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:43.252361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:41.7174Z","time spent":"1.534881981s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:950 > 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-26T16:48:43.419162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.837947ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287938903 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:949 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T16:48:43.419268Z","caller":"traceutil/trace.go:171","msg":"trace[684354643] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"1.698890135s","start":"2026-02-26T16:48:41.720366Z","end":"2026-02-26T16:48:43.419256Z","steps":["trace[684354643] 'process raft request'  (duration: 1.566907815s)","trace[684354643] 'compare'  (duration: 131.189543ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:43.4193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:41.720347Z","time spent":"1.698938056s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:949 > 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":"info","ts":"2026-02-26T16:48:43.419373Z","caller":"traceutil/trace.go:171","msg":"trace[290124367] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:994; }","duration":"1.633840055s","start":"2026-02-26T16:48:41.785529Z","end":"2026-02-26T16:48:43.419369Z","steps":["trace[290124367] 'read index received'  (duration: 1.466528697s)","trace[290124367] 'applied index is now lower than readState.Index'  (duration: 167.310868ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:48:43.419437Z","caller":"traceutil/trace.go:171","msg":"trace[393300919] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"1.673041338s","start":"2026-02-26T16:48:41.746392Z","end":"2026-02-26T16:48:43.419434Z","steps":["trace[393300919] 'process raft request'  (duration: 1.672837404s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:43.419462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:41.746381Z","time spent":"1.673064909s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:934 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-26T16:48:43.419544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.634016959s","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-26T16:48:43.419557Z","caller":"traceutil/trace.go:171","msg":"trace[424024115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:958; }","duration":"1.63405984s","start":"2026-02-26T16:48:41.785492Z","end":"2026-02-26T16:48:43.419551Z","steps":["trace[424024115] 'agreement among raft nodes before linearized reading'  (duration: 1.634004899s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:43.419569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:41.785475Z","time spent":"1.63409207s","remote":"127.0.0.1:48506","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-26T16:48:43.463672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.663924506s","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-26T16:48:43.464029Z","caller":"traceutil/trace.go:171","msg":"trace[407750147] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:959; }","duration":"1.664325825s","start":"2026-02-26T16:48:41.799684Z","end":"2026-02-26T16:48:43.464009Z","steps":["trace[407750147] 'agreement among raft nodes before linearized reading'  (duration: 1.663814844s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:43.46431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:41.799669Z","time spent":"1.664624861s","remote":"127.0.0.1:48506","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-26T16:48:43.463702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.397089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:43.464892Z","caller":"traceutil/trace.go:171","msg":"trace[1990566030] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:959; }","duration":"312.615426ms","start":"2026-02-26T16:48:43.152248Z","end":"2026-02-26T16:48:43.464864Z","steps":["trace[1990566030] 'agreement among raft nodes before linearized reading'  (duration: 311.386059ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:43.46365Z","caller":"traceutil/trace.go:171","msg":"trace[623244126] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"159.122616ms","start":"2026-02-26T16:48:43.30446Z","end":"2026-02-26T16:48:43.463582Z","steps":["trace[623244126] 'process raft request'  (duration: 158.895461ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:43.463826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.810868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-26T16:48:43.465277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:43.152231Z","time spent":"313.025284ms","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-26T16:48:43.465835Z","caller":"traceutil/trace.go:171","msg":"trace[1236681414] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:959; }","duration":"865.811142ms","start":"2026-02-26T16:48:42.60001Z","end":"2026-02-26T16:48:43.465821Z","steps":["trace[1236681414] 'agreement among raft nodes before linearized reading'  (duration: 863.731856ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:43.466495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:42.599955Z","time spent":"866.529169ms","remote":"127.0.0.1:48506","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-26T16:48:43.722503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.130039ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287938909 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:955 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T16:48:43.722686Z","caller":"traceutil/trace.go:171","msg":"trace[2011549838] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"251.463794ms","start":"2026-02-26T16:48:43.471209Z","end":"2026-02-26T16:48:43.722673Z","steps":["trace[2011549838] 'process raft request'  (duration: 251.376502ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:43.722748Z","caller":"traceutil/trace.go:171","msg":"trace[1457010060] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"251.580426ms","start":"2026-02-26T16:48:43.471145Z","end":"2026-02-26T16:48:43.722725Z","steps":["trace[1457010060] 'process raft request'  (duration: 99.13409ms)","trace[1457010060] 'compare'  (duration: 151.856123ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:45.243913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.597571ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:45.244682Z","caller":"traceutil/trace.go:171","msg":"trace[536014658] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:963; }","duration":"867.374888ms","start":"2026-02-26T16:48:44.377283Z","end":"2026-02-26T16:48:45.244658Z","steps":["trace[536014658] 'range keys from in-memory index tree'  (duration: 866.581631ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.446552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.013665ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287938913 > lease_revoke:<id:38ca9c9ad85628f6>","response":"size:28"}
{"level":"info","ts":"2026-02-26T16:48:45.446758Z","caller":"traceutil/trace.go:171","msg":"trace[1750187310] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"1.235745484s","start":"2026-02-26T16:48:44.211002Z","end":"2026-02-26T16:48:45.446747Z","steps":["trace[1750187310] 'process raft request'  (duration: 1.235635732s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.446824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:44.210967Z","time spent":"1.235817886s","remote":"127.0.0.1:48318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":750,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-d8fc6.1897d9dd9b31dd45\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-d8fc6.1897d9dd9b31dd45\" value_size:657 lease:4092255400287938677 >> failure:<>"}
{"level":"info","ts":"2026-02-26T16:48:45.446969Z","caller":"traceutil/trace.go:171","msg":"trace[1639639961] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1002; }","duration":"1.330897704s","start":"2026-02-26T16:48:44.116066Z","end":"2026-02-26T16:48:45.446963Z","steps":["trace[1639639961] 'read index received'  (duration: 464.348586ms)","trace[1639639961] 'applied index is now lower than readState.Index'  (duration: 866.548518ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:45.447074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331007566s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-26T16:48:45.447088Z","caller":"traceutil/trace.go:171","msg":"trace[615648149] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:964; }","duration":"1.331063328s","start":"2026-02-26T16:48:44.11602Z","end":"2026-02-26T16:48:45.447084Z","steps":["trace[615648149] 'agreement among raft nodes before linearized reading'  (duration: 1.331001516s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.447103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:44.115999Z","time spent":"1.331101028s","remote":"127.0.0.1:48490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "}
{"level":"warn","ts":"2026-02-26T16:48:45.447182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.274268953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:45.447193Z","caller":"traceutil/trace.go:171","msg":"trace[371572612] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:964; }","duration":"1.274310583s","start":"2026-02-26T16:48:44.172879Z","end":"2026-02-26T16:48:45.44719Z","steps":["trace[371572612] 'agreement among raft nodes before linearized reading'  (duration: 1.274288892s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.447204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:44.172864Z","time spent":"1.274338134s","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-26T16:48:45.447442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.149097ms","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-26T16:48:45.447463Z","caller":"traceutil/trace.go:171","msg":"trace[1255174718] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:964; }","duration":"190.201349ms","start":"2026-02-26T16:48:45.257257Z","end":"2026-02-26T16:48:45.447458Z","steps":["trace[1255174718] 'agreement among raft nodes before linearized reading'  (duration: 190.149698ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.447525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.069933949s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:45.447556Z","caller":"traceutil/trace.go:171","msg":"trace[1949084287] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:964; }","duration":"1.070058222s","start":"2026-02-26T16:48:44.377494Z","end":"2026-02-26T16:48:45.447553Z","steps":["trace[1949084287] 'agreement among raft nodes before linearized reading'  (duration: 1.070020231s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.447569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:44.377461Z","time spent":"1.070103633s","remote":"127.0.0.1:48546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "}
{"level":"warn","ts":"2026-02-26T16:48:45.447639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.07670022s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-26T16:48:45.447656Z","caller":"traceutil/trace.go:171","msg":"trace[79510003] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:964; }","duration":"1.07675819s","start":"2026-02-26T16:48:44.370894Z","end":"2026-02-26T16:48:45.447653Z","steps":["trace[79510003] 'agreement among raft nodes before linearized reading'  (duration: 1.076731679s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.447668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:44.370873Z","time spent":"1.076792171s","remote":"127.0.0.1:48360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":4,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "}
{"level":"warn","ts":"2026-02-26T16:48:45.447777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.1184443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5366"}
{"level":"info","ts":"2026-02-26T16:48:45.447794Z","caller":"traceutil/trace.go:171","msg":"trace[1285764021] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:964; }","duration":"1.118492821s","start":"2026-02-26T16:48:44.329298Z","end":"2026-02-26T16:48:45.447791Z","steps":["trace[1285764021] 'agreement among raft nodes before linearized reading'  (duration: 1.118428199s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.447809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:44.329271Z","time spent":"1.118534451s","remote":"127.0.0.1:48404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5389,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-02-26T16:48:45.781511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.585095ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287938918 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:957 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T16:48:45.781622Z","caller":"traceutil/trace.go:171","msg":"trace[1491381135] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"329.511353ms","start":"2026-02-26T16:48:45.452094Z","end":"2026-02-26T16:48:45.781606Z","steps":["trace[1491381135] 'process raft request'  (duration: 129.434207ms)","trace[1491381135] 'compare'  (duration: 199.3244ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:45.781761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:45.452073Z","time spent":"329.660267ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:957 > 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":"info","ts":"2026-02-26T16:48:45.873176Z","caller":"traceutil/trace.go:171","msg":"trace[1883962210] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1004; }","duration":"417.697959ms","start":"2026-02-26T16:48:45.455455Z","end":"2026-02-26T16:48:45.873153Z","steps":["trace[1883962210] 'read index received'  (duration: 126.076932ms)","trace[1883962210] 'applied index is now lower than readState.Index'  (duration: 291.620117ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:48:45.873295Z","caller":"traceutil/trace.go:171","msg":"trace[24008411] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"420.88427ms","start":"2026-02-26T16:48:45.452401Z","end":"2026-02-26T16:48:45.873285Z","steps":["trace[24008411] 'process raft request'  (duration: 420.585883ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.87348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:45.452392Z","time spent":"420.991302ms","remote":"127.0.0.1:48318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":750,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-d8fc6.1897d9dddd03c1a9\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-d8fc6.1897d9dddd03c1a9\" value_size:657 lease:4092255400287938677 >> failure:<>"}
{"level":"warn","ts":"2026-02-26T16:48:45.873515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.030236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:45.873581Z","caller":"traceutil/trace.go:171","msg":"trace[2030132333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:967; }","duration":"418.122069ms","start":"2026-02-26T16:48:45.455438Z","end":"2026-02-26T16:48:45.873561Z","steps":["trace[2030132333] 'agreement among raft nodes before linearized reading'  (duration: 417.920544ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.873607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.961679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-26T16:48:45.873616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:45.455431Z","time spent":"418.17858ms","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-26T16:48:45.87359Z","caller":"traceutil/trace.go:171","msg":"trace[479428314] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"415.098932ms","start":"2026-02-26T16:48:45.458451Z","end":"2026-02-26T16:48:45.87355Z","steps":["trace[479428314] 'process raft request'  (duration: 414.646702ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.873707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.032019ms","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-26T16:48:45.873722Z","caller":"traceutil/trace.go:171","msg":"trace[1895999558] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:967; }","duration":"144.066709ms","start":"2026-02-26T16:48:45.729651Z","end":"2026-02-26T16:48:45.873718Z","steps":["trace[1895999558] 'agreement among raft nodes before linearized reading'  (duration: 144.000478ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.873758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:45.458443Z","time spent":"415.227505ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:956 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-26T16:48:45.873641Z","caller":"traceutil/trace.go:171","msg":"trace[626381090] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:967; }","duration":"391.023851ms","start":"2026-02-26T16:48:45.482607Z","end":"2026-02-26T16:48:45.87363Z","steps":["trace[626381090] 'agreement among raft nodes before linearized reading'  (duration: 390.95989ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.873848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.681294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-26T16:48:45.873864Z","caller":"traceutil/trace.go:171","msg":"trace[803142941] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:967; }","duration":"144.740135ms","start":"2026-02-26T16:48:45.729119Z","end":"2026-02-26T16:48:45.873859Z","steps":["trace[803142941] 'agreement among raft nodes before linearized reading'  (duration: 144.697564ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.873867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:45.482595Z","time spent":"391.253166ms","remote":"127.0.0.1:48454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-02-26T16:48:45.873916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.350111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-26T16:48:45.873945Z","caller":"traceutil/trace.go:171","msg":"trace[754736899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:967; }","duration":"359.387172ms","start":"2026-02-26T16:48:45.514553Z","end":"2026-02-26T16:48:45.87394Z","steps":["trace[754736899] 'agreement among raft nodes before linearized reading'  (duration: 359.322431ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.873952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.105164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-02-26T16:48:45.87396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:45.514547Z","time spent":"359.409952ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-26T16:48:45.873965Z","caller":"traceutil/trace.go:171","msg":"trace[1634566923] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:967; }","duration":"305.139975ms","start":"2026-02-26T16:48:45.56882Z","end":"2026-02-26T16:48:45.87396Z","steps":["trace[1634566923] 'agreement among raft nodes before linearized reading'  (duration: 305.118235ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.873981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:45.568808Z","time spent":"305.169286ms","remote":"127.0.0.1:35328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "}
{"level":"warn","ts":"2026-02-26T16:48:45.873924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.478965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:45.874001Z","caller":"traceutil/trace.go:171","msg":"trace[1402710354] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:967; }","duration":"359.582146ms","start":"2026-02-26T16:48:45.514414Z","end":"2026-02-26T16:48:45.873996Z","steps":["trace[1402710354] 'agreement among raft nodes before linearized reading'  (duration: 359.498354ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:45.874013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:45.514399Z","time spent":"359.610078ms","remote":"127.0.0.1:48626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" "}
{"level":"warn","ts":"2026-02-26T16:48:46.286977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.088687ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287938923 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:961 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T16:48:46.287107Z","caller":"traceutil/trace.go:171","msg":"trace[1531536551] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"409.574752ms","start":"2026-02-26T16:48:45.87751Z","end":"2026-02-26T16:48:46.287084Z","steps":["trace[1531536551] 'process raft request'  (duration: 35.271279ms)","trace[1531536551] 'compare'  (duration: 373.841962ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:46.287215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:45.87749Z","time spent":"409.677773ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:961 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-26T16:48:46.545821Z","caller":"traceutil/trace.go:171","msg":"trace[1678718488] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"667.485203ms","start":"2026-02-26T16:48:45.878313Z","end":"2026-02-26T16:48:46.545798Z","steps":["trace[1678718488] 'process raft request'  (duration: 667.36338ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:46.545962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:45.878306Z","time spent":"667.585755ms","remote":"127.0.0.1:48318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":821,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-d8fc6.1897d9ddde903be0\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-d8fc6.1897d9ddde903be0\" value_size:728 lease:4092255400287938677 >> failure:<>"}
{"level":"info","ts":"2026-02-26T16:48:46.54609Z","caller":"traceutil/trace.go:171","msg":"trace[136129216] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"665.776046ms","start":"2026-02-26T16:48:45.880249Z","end":"2026-02-26T16:48:46.546025Z","steps":["trace[136129216] 'process raft request'  (duration: 665.491619ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:46.546111Z","caller":"traceutil/trace.go:171","msg":"trace[313196671] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"668.094886ms","start":"2026-02-26T16:48:45.877983Z","end":"2026-02-26T16:48:46.546077Z","steps":["trace[313196671] 'process raft request'  (duration: 667.549294ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:46.546228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:45.880228Z","time spent":"665.920829ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:960 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-26T16:48:46.546308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:45.877968Z","time spent":"668.23944ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:962 > 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-26T16:48:51.984751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.586704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:51.984991Z","caller":"traceutil/trace.go:171","msg":"trace[433459506] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1015; }","duration":"102.948223ms","start":"2026-02-26T16:48:51.882023Z","end":"2026-02-26T16:48:51.984971Z","steps":["trace[433459506] 'range keys from in-memory index tree'  (duration: 102.496082ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:53.024244Z","caller":"traceutil/trace.go:171","msg":"trace[2056132566] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"447.745774ms","start":"2026-02-26T16:48:52.576465Z","end":"2026-02-26T16:48:53.024211Z","steps":["trace[2056132566] 'process raft request'  (duration: 447.535079ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:53.024581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:52.576444Z","time spent":"447.99021ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1011 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-26T16:48:54.743743Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.22459858s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-26T16:48:54.97131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.205956ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:54.971463Z","caller":"traceutil/trace.go:171","msg":"trace[1100660566] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1023; }","duration":"594.370949ms","start":"2026-02-26T16:48:54.377068Z","end":"2026-02-26T16:48:54.971439Z","steps":["trace[1100660566] 'range keys from in-memory index tree'  (duration: 594.187375ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:54.971788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.853211255s","expected-duration":"100ms","prefix":"","request":"header:<ID:4092255400287939018 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1012 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T16:48:54.97199Z","caller":"traceutil/trace.go:171","msg":"trace[1061310898] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"2.393208494s","start":"2026-02-26T16:48:52.578762Z","end":"2026-02-26T16:48:54.97197Z","steps":["trace[1061310898] 'process raft request'  (duration: 539.700173ms)","trace[1061310898] 'compare'  (duration: 1.852249223s)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T16:48:54.97212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:52.578732Z","time spent":"2.393311657s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1012 > 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-26T16:48:54.972173Z","caller":"traceutil/trace.go:171","msg":"trace[2035409534] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"1.04157236s","start":"2026-02-26T16:48:53.930536Z","end":"2026-02-26T16:48:54.972109Z","steps":["trace[2035409534] 'process raft request'  (duration: 1.041509069s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:54.972288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:53.930511Z","time spent":"1.041725714s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:963 > 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-26T16:48:54.972361Z","caller":"traceutil/trace.go:171","msg":"trace[1164745057] linearizableReadLoop","detail":"{readStateIndex:1065; appliedIndex:1064; }","duration":"1.818731023s","start":"2026-02-26T16:48:53.153609Z","end":"2026-02-26T16:48:54.97234Z","steps":["trace[1164745057] 'read index received'  (duration: 84.191µs)","trace[1164745057] 'applied index is now lower than readState.Index'  (duration: 1.818645602s)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:48:54.972462Z","caller":"traceutil/trace.go:171","msg":"trace[18567888] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"1.453271377s","start":"2026-02-26T16:48:53.519033Z","end":"2026-02-26T16:48:54.972305Z","steps":["trace[18567888] 'process raft request'  (duration: 1.452896269s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:54.972501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.818895117s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:54.972818Z","caller":"traceutil/trace.go:171","msg":"trace[459254230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1026; }","duration":"1.819237624s","start":"2026-02-26T16:48:53.153541Z","end":"2026-02-26T16:48:54.972778Z","steps":["trace[459254230] 'agreement among raft nodes before linearized reading'  (duration: 1.818918578s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:54.972861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:53.15351Z","time spent":"1.819339756s","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-26T16:48:54.973088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.158411048s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-26T16:48:54.973127Z","caller":"traceutil/trace.go:171","msg":"trace[1533737697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1026; }","duration":"1.15848874s","start":"2026-02-26T16:48:53.814629Z","end":"2026-02-26T16:48:54.973117Z","steps":["trace[1533737697] 'agreement among raft nodes before linearized reading'  (duration: 1.158372647s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:54.973155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:53.814608Z","time spent":"1.158540251s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-26T16:48:54.973304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.434289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T16:48:54.97334Z","caller":"traceutil/trace.go:171","msg":"trace[1755644890] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1026; }","duration":"540.552141ms","start":"2026-02-26T16:48:54.43278Z","end":"2026-02-26T16:48:54.973332Z","steps":["trace[1755644890] 'agreement among raft nodes before linearized reading'  (duration: 540.47252ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:54.973368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:54.432766Z","time spent":"540.592782ms","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-26T16:48:54.973524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.841907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-26T16:48:54.973561Z","caller":"traceutil/trace.go:171","msg":"trace[1140158178] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1026; }","duration":"574.912079ms","start":"2026-02-26T16:48:54.39864Z","end":"2026-02-26T16:48:54.973553Z","steps":["trace[1140158178] 'agreement among raft nodes before linearized reading'  (duration: 574.823157ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:54.973586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:54.398621Z","time spent":"574.958891ms","remote":"127.0.0.1:48506","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-26T16:48:54.973702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.154952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"}
{"level":"warn","ts":"2026-02-26T16:48:54.973805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.503239ms","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-26T16:48:54.973837Z","caller":"traceutil/trace.go:171","msg":"trace[1545315779] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1026; }","duration":"912.228764ms","start":"2026-02-26T16:48:54.061499Z","end":"2026-02-26T16:48:54.973728Z","steps":["trace[1545315779] 'agreement among raft nodes before linearized reading'  (duration: 912.153632ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:48:54.973859Z","caller":"traceutil/trace.go:171","msg":"trace[469682240] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1026; }","duration":"974.593701ms","start":"2026-02-26T16:48:53.999251Z","end":"2026-02-26T16:48:54.973845Z","steps":["trace[469682240] 'agreement among raft nodes before linearized reading'  (duration: 974.484728ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:48:54.973883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:54.061475Z","time spent":"912.396057ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-26T16:48:54.973905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:53.999229Z","time spent":"974.664842ms","remote":"127.0.0.1:48506","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-26T16:48:54.972766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:48:53.519008Z","time spent":"1.453604925s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:958 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-26T16:49:42.20971Z","caller":"traceutil/trace.go:171","msg":"trace[1713505467] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"100.340846ms","start":"2026-02-26T16:49:42.109341Z","end":"2026-02-26T16:49:42.209682Z","steps":["trace[1713505467] 'process raft request'  (duration: 100.194832ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:50:10.822283Z","caller":"traceutil/trace.go:171","msg":"trace[1959085828] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"131.96617ms","start":"2026-02-26T16:50:10.690292Z","end":"2026-02-26T16:50:10.822258Z","steps":["trace[1959085828] 'process raft request'  (duration: 131.839778ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T16:50:34.17034Z","caller":"traceutil/trace.go:171","msg":"trace[2064431936] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"137.290545ms","start":"2026-02-26T16:50:34.03297Z","end":"2026-02-26T16:50:34.17026Z","steps":["trace[2064431936] 'process raft request'  (duration: 60.863469ms)","trace[2064431936] 'compare'  (duration: 76.218062ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:52:07.816876Z","caller":"traceutil/trace.go:171","msg":"trace[290917726] linearizableReadLoop","detail":"{readStateIndex:1941; appliedIndex:1940; }","duration":"252.917322ms","start":"2026-02-26T16:52:07.563938Z","end":"2026-02-26T16:52:07.816856Z","steps":["trace[290917726] 'read index received'  (duration: 252.739008ms)","trace[290917726] 'applied index is now lower than readState.Index'  (duration: 177.304µs)"],"step_count":2}
{"level":"info","ts":"2026-02-26T16:52:07.816965Z","caller":"traceutil/trace.go:171","msg":"trace[1401080522] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"394.545467ms","start":"2026-02-26T16:52:07.422392Z","end":"2026-02-26T16:52:07.816938Z","steps":["trace[1401080522] 'process raft request'  (duration: 394.306102ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:52:07.817165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.185797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"}
{"level":"info","ts":"2026-02-26T16:52:07.817283Z","caller":"traceutil/trace.go:171","msg":"trace[1171005609] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1860; }","duration":"253.360371ms","start":"2026-02-26T16:52:07.563896Z","end":"2026-02-26T16:52:07.817256Z","steps":["trace[1171005609] 'agreement among raft nodes before linearized reading'  (duration: 253.060165ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T16:52:07.817385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:52:07.422376Z","time spent":"394.809083ms","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1849 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:451 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >"}