{"level":"warn","ts":"2026-03-14T01:32:22.067105Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-14T01:32:22.067183Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-03-14T01:32:22.067316Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-14T01:32:22.067332Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]}
{"level":"info","ts":"2026-03-14T01:32:22.067383Z","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-03-14T01:32:22.067988Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]}
{"level":"info","ts":"2026-03-14T01:32:22.068057Z","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://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-03-14T01:32:22.073315Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.621567ms"}
{"level":"info","ts":"2026-03-14T01:32:22.080368Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"}
{"level":"info","ts":"2026-03-14T01:32:22.080482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"}
{"level":"info","ts":"2026-03-14T01:32:22.080514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"}
{"level":"info","ts":"2026-03-14T01:32:22.080534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-14T01:32:22.080555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"}
{"level":"info","ts":"2026-03-14T01:32:22.080608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"}
{"level":"warn","ts":"2026-03-14T01:32:22.091277Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-14T01:32:22.092746Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-14T01:32:22.094592Z","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-03-14T01:32:22.097798Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-14T01:32:22.098277Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-14T01:32:22.098446Z","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-03-14T01:32:22.098542Z","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-03-14T01:32:22.098586Z","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-03-14T01:32:22.102804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"}
{"level":"info","ts":"2026-03-14T01:32:22.103382Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]}
{"level":"info","ts":"2026-03-14T01:32:22.104899Z","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-03-14T01:32:22.104947Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"}
{"level":"info","ts":"2026-03-14T01:32:22.105015Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"}
{"level":"info","ts":"2026-03-14T01:32:22.10529Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-14T01:32:22.105393Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-14T01:32:22.781454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"}
{"level":"info","ts":"2026-03-14T01:32:22.781511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-14T01:32:22.781552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"}
{"level":"info","ts":"2026-03-14T01:32:22.781577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"}
{"level":"info","ts":"2026-03-14T01:32:22.781594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"}
{"level":"info","ts":"2026-03-14T01:32:22.781617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"}
{"level":"info","ts":"2026-03-14T01:32:22.781636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"}
{"level":"info","ts":"2026-03-14T01:32:22.782646Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-14T01:32:22.782895Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-14T01:32:22.782908Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-14T01:32:22.786002Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-14T01:32:22.786114Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-14T01:32:22.786138Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-14T01:32:22.786441Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-14T01:32:22.786535Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-14T01:32:22.789227Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"}
{"level":"info","ts":"2026-03-14T01:32:22.793501Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-14T01:32:22.793574Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-14T01:32:50.333163Z","caller":"traceutil/trace.go:171","msg":"trace[1994654093] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"105.971269ms","start":"2026-03-14T01:32:50.227153Z","end":"2026-03-14T01:32:50.333124Z","steps":["trace[1994654093] 'process raft request'  (duration: 12.987779ms)","trace[1994654093] 'compare'  (duration: 92.728174ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:32:50.399999Z","caller":"traceutil/trace.go:171","msg":"trace[442812550] linearizableReadLoop","detail":"{readStateIndex:486; appliedIndex:485; }","duration":"157.094949ms","start":"2026-03-14T01:32:50.242877Z","end":"2026-03-14T01:32:50.399972Z","steps":["trace[442812550] 'read index received'  (duration: 156.886744ms)","trace[442812550] 'applied index is now lower than readState.Index'  (duration: 206.565µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:32:50.400063Z","caller":"traceutil/trace.go:171","msg":"trace[2003375948] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"171.913918ms","start":"2026-03-14T01:32:50.228108Z","end":"2026-03-14T01:32:50.400022Z","steps":["trace[2003375948] 'process raft request'  (duration: 171.741764ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:32:50.40037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.475847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-14T01:32:50.400462Z","caller":"traceutil/trace.go:171","msg":"trace[456637396] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:470; }","duration":"157.627271ms","start":"2026-03-14T01:32:50.242821Z","end":"2026-03-14T01:32:50.400448Z","steps":["trace[456637396] 'agreement among raft nodes before linearized reading'  (duration: 157.244853ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:32:55.82774Z","caller":"traceutil/trace.go:171","msg":"trace[2008524129] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:530; }","duration":"309.15296ms","start":"2026-03-14T01:32:55.518547Z","end":"2026-03-14T01:32:55.8277Z","steps":["trace[2008524129] 'read index received'  (duration: 308.930186ms)","trace[2008524129] 'applied index is now lower than readState.Index'  (duration: 221.084µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:32:55.827832Z","caller":"traceutil/trace.go:171","msg":"trace[276230844] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"388.465647ms","start":"2026-03-14T01:32:55.439302Z","end":"2026-03-14T01:32:55.827767Z","steps":["trace[276230844] 'process raft request'  (duration: 388.16686ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:32:55.828049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.452257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-14T01:32:55.828132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.9333ms","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-03-14T01:32:55.828191Z","caller":"traceutil/trace.go:171","msg":"trace[1286782484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:514; }","duration":"299.071653ms","start":"2026-03-14T01:32:55.529098Z","end":"2026-03-14T01:32:55.828169Z","steps":["trace[1286782484] 'agreement among raft nodes before linearized reading'  (duration: 298.829118ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:32:55.828179Z","caller":"traceutil/trace.go:171","msg":"trace[1351282556] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:514; }","duration":"309.659022ms","start":"2026-03-14T01:32:55.518489Z","end":"2026-03-14T01:32:55.828148Z","steps":["trace[1351282556] 'agreement among raft nodes before linearized reading'  (duration: 309.392996ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:32:55.828305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:32:55.518463Z","time spent":"309.830445ms","remote":"127.0.0.1:52986","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-03-14T01:32:55.828575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:32:55.439271Z","time spent":"388.6472ms","remote":"127.0.0.1:53218","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:509 > 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-03-14T01:32:56.623799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.398139ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071097457 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:510 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:32:56.623942Z","caller":"traceutil/trace.go:171","msg":"trace[840653952] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:531; }","duration":"718.29144ms","start":"2026-03-14T01:32:55.905631Z","end":"2026-03-14T01:32:56.623923Z","steps":["trace[840653952] 'read index received'  (duration: 69.602µs)","trace[840653952] 'applied index is now lower than readState.Index'  (duration: 718.220078ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:32:56.624051Z","caller":"traceutil/trace.go:171","msg":"trace[464611901] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"755.407858ms","start":"2026-03-14T01:32:55.868631Z","end":"2026-03-14T01:32:56.624039Z","steps":["trace[464611901] 'process raft request'  (duration: 11.483378ms)","trace[464611901] 'compare'  (duration: 743.146814ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:32:56.624111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:32:55.868607Z","time spent":"755.47155ms","remote":"127.0.0.1:53218","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:510 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-14T01:32:56.624266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.672494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-14T01:32:56.624365Z","caller":"traceutil/trace.go:171","msg":"trace[909107898] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"192.824798ms","start":"2026-03-14T01:32:56.431515Z","end":"2026-03-14T01:32:56.62434Z","steps":["trace[909107898] 'agreement among raft nodes before linearized reading'  (duration: 192.591873ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:32:56.624507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.646022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-14T01:32:56.624521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.894782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"}
{"level":"info","ts":"2026-03-14T01:32:56.624535Z","caller":"traceutil/trace.go:171","msg":"trace[306489057] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"105.714613ms","start":"2026-03-14T01:32:56.518811Z","end":"2026-03-14T01:32:56.624525Z","steps":["trace[306489057] 'agreement among raft nodes before linearized reading'  (duration: 105.671822ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:32:56.624557Z","caller":"traceutil/trace.go:171","msg":"trace[810050373] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:515; }","duration":"718.976524ms","start":"2026-03-14T01:32:55.90557Z","end":"2026-03-14T01:32:56.624547Z","steps":["trace[810050373] 'agreement among raft nodes before linearized reading'  (duration: 718.888872ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:32:56.624593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:32:55.905543Z","time spent":"719.043876ms","remote":"127.0.0.1:53008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.4\" "}
{"level":"warn","ts":"2026-03-14T01:32:57.130112Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232309988071097459,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-14T01:32:57.454854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.113085ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071097461 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:567d9ce9f918c474>","response":"size:40"}
{"level":"info","ts":"2026-03-14T01:32:57.455127Z","caller":"traceutil/trace.go:171","msg":"trace[1051817268] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:532; }","duration":"825.546038ms","start":"2026-03-14T01:32:56.629563Z","end":"2026-03-14T01:32:57.455109Z","steps":["trace[1051817268] 'read index received'  (duration: 525.179027ms)","trace[1051817268] 'applied index is now lower than readState.Index'  (duration: 300.366081ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:32:57.455321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.753682ms","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-03-14T01:32:57.455312Z","caller":"traceutil/trace.go:171","msg":"trace[913188302] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"825.515337ms","start":"2026-03-14T01:32:56.629756Z","end":"2026-03-14T01:32:57.455271Z","steps":["trace[913188302] 'process raft request'  (duration: 825.227101ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:32:57.455359Z","caller":"traceutil/trace.go:171","msg":"trace[275395596] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:516; }","duration":"825.838644ms","start":"2026-03-14T01:32:56.629512Z","end":"2026-03-14T01:32:57.45535Z","steps":["trace[275395596] 'agreement among raft nodes before linearized reading'  (duration: 825.65967ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:32:57.455357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:32:56.626851Z","time spent":"828.498421ms","remote":"127.0.0.1:53008","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-14T01:32:57.455498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:32:56.62973Z","time spent":"825.65973ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:511 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-14T01:32:57.455398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:32:56.629493Z","time spent":"825.896515ms","remote":"127.0.0.1:53218","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-03-14T01:32:57.950892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.077437ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071097465 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:512 > 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-03-14T01:32:57.950985Z","caller":"traceutil/trace.go:171","msg":"trace[1947610539] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:535; }","duration":"480.640568ms","start":"2026-03-14T01:32:57.470331Z","end":"2026-03-14T01:32:57.950972Z","steps":["trace[1947610539] 'read index received'  (duration: 106.340517ms)","trace[1947610539] 'applied index is now lower than readState.Index'  (duration: 374.299261ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:32:57.95108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.758861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:420"}
{"level":"info","ts":"2026-03-14T01:32:57.951058Z","caller":"traceutil/trace.go:171","msg":"trace[1875778309] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"490.777306ms","start":"2026-03-14T01:32:57.46023Z","end":"2026-03-14T01:32:57.951007Z","steps":["trace[1875778309] 'process raft request'  (duration: 116.510395ms)","trace[1875778309] 'compare'  (duration: 373.960424ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:32:57.951108Z","caller":"traceutil/trace.go:171","msg":"trace[530059068] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:518; }","duration":"480.861583ms","start":"2026-03-14T01:32:57.470237Z","end":"2026-03-14T01:32:57.951098Z","steps":["trace[530059068] 'agreement among raft nodes before linearized reading'  (duration: 480.809122ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:32:57.951156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:32:57.470203Z","time spent":"480.946905ms","remote":"127.0.0.1:53144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":443,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"warn","ts":"2026-03-14T01:32:57.951281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:32:57.460215Z","time spent":"490.934539ms","remote":"127.0.0.1:53218","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:512 > 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-03-14T01:32:57.95129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.912682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:32:57.951413Z","caller":"traceutil/trace.go:171","msg":"trace[132565038] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"433.070915ms","start":"2026-03-14T01:32:57.518322Z","end":"2026-03-14T01:32:57.951393Z","steps":["trace[132565038] 'agreement among raft nodes before linearized reading'  (duration: 432.892331ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:32:57.951481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:32:57.518309Z","time spent":"433.161148ms","remote":"127.0.0.1:52984","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-03-14T01:32:58.242072Z","caller":"traceutil/trace.go:171","msg":"trace[14075439] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"285.693646ms","start":"2026-03-14T01:32:57.956323Z","end":"2026-03-14T01:32:58.242017Z","steps":["trace[14075439] 'process raft request'  (duration: 268.340012ms)","trace[14075439] 'compare'  (duration: 17.092428ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:33:04.930401Z","caller":"traceutil/trace.go:171","msg":"trace[1622587302] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"174.439511ms","start":"2026-03-14T01:33:04.755889Z","end":"2026-03-14T01:33:04.930329Z","steps":["trace[1622587302] 'process raft request'  (duration: 174.243737ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:06.052456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.529306ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071097514 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:513 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:33:06.052566Z","caller":"traceutil/trace.go:171","msg":"trace[1285830122] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:556; }","duration":"533.155208ms","start":"2026-03-14T01:33:05.51939Z","end":"2026-03-14T01:33:06.052545Z","steps":["trace[1285830122] 'read index received'  (duration: 171.412847ms)","trace[1285830122] 'applied index is now lower than readState.Index'  (duration: 361.741291ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:33:06.052626Z","caller":"traceutil/trace.go:171","msg":"trace[884124294] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.153735136s","start":"2026-03-14T01:33:04.898864Z","end":"2026-03-14T01:33:06.052599Z","steps":["trace[884124294] 'process raft request'  (duration: 791.970865ms)","trace[884124294] 'compare'  (duration: 361.438944ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:33:06.052763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:04.898832Z","time spent":"1.153853749s","remote":"127.0.0.1:53218","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:513 > 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-03-14T01:33:06.052774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.057557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-14T01:33:06.05281Z","caller":"traceutil/trace.go:171","msg":"trace[370843847] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:538; }","duration":"494.091009ms","start":"2026-03-14T01:33:05.558709Z","end":"2026-03-14T01:33:06.0528Z","steps":["trace[370843847] 'agreement among raft nodes before linearized reading'  (duration: 493.970746ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:06.052842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:05.558673Z","time spent":"494.16208ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-14T01:33:06.052657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.277281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:33:06.05301Z","caller":"traceutil/trace.go:171","msg":"trace[1001658462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:538; }","duration":"533.66951ms","start":"2026-03-14T01:33:05.519327Z","end":"2026-03-14T01:33:06.052997Z","steps":["trace[1001658462] 'agreement among raft nodes before linearized reading'  (duration: 533.301472ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:06.053049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:05.519303Z","time spent":"533.736401ms","remote":"127.0.0.1:52986","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-03-14T01:33:06.054061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.928151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"}
{"level":"info","ts":"2026-03-14T01:33:06.054152Z","caller":"traceutil/trace.go:171","msg":"trace[21619636] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:538; }","duration":"148.057985ms","start":"2026-03-14T01:33:05.906075Z","end":"2026-03-14T01:33:06.054133Z","steps":["trace[21619636] 'agreement among raft nodes before linearized reading'  (duration: 146.960912ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:06.383984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.796229ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071097519 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:567d9ce9f918c4ae>","response":"size:40"}
{"level":"info","ts":"2026-03-14T01:33:06.384178Z","caller":"traceutil/trace.go:171","msg":"trace[1819528290] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:557; }","duration":"102.31462ms","start":"2026-03-14T01:33:06.281849Z","end":"2026-03-14T01:33:06.384164Z","steps":["trace[1819528290] 'read index received'  (duration: 68.071143ms)","trace[1819528290] 'applied index is now lower than readState.Index'  (duration: 34.242537ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:33:06.384302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.462384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-14T01:33:06.384326Z","caller":"traceutil/trace.go:171","msg":"trace[248340779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:540; }","duration":"102.559185ms","start":"2026-03-14T01:33:06.28176Z","end":"2026-03-14T01:33:06.384319Z","steps":["trace[248340779] 'agreement among raft nodes before linearized reading'  (duration: 102.447683ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:06.384408Z","caller":"traceutil/trace.go:171","msg":"trace[1884430528] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"327.622297ms","start":"2026-03-14T01:33:06.056763Z","end":"2026-03-14T01:33:06.384385Z","steps":["trace[1884430528] 'process raft request'  (duration: 327.29747ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:06.384451Z","caller":"traceutil/trace.go:171","msg":"trace[94930929] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"327.624527ms","start":"2026-03-14T01:33:06.05682Z","end":"2026-03-14T01:33:06.384444Z","steps":["trace[94930929] 'process raft request'  (duration: 327.31823ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:06.384488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:06.056745Z","time spent":"327.692089ms","remote":"127.0.0.1:53218","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:531 > 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-03-14T01:33:06.384497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:06.056801Z","time spent":"327.670348ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:530 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-14T01:33:06.384548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:06.055328Z","time spent":"329.219331ms","remote":"127.0.0.1:53008","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-14T01:33:08.300902Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.446142186s","expected-duration":"1s"}
{"level":"warn","ts":"2026-03-14T01:33:09.430986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.855253ms","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-03-14T01:33:09.431206Z","caller":"traceutil/trace.go:171","msg":"trace[457425898] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:540; }","duration":"752.114148ms","start":"2026-03-14T01:33:08.679058Z","end":"2026-03-14T01:33:09.431172Z","steps":["trace[457425898] 'range keys from in-memory index tree'  (duration: 751.820302ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:09.432015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.577152794s","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071097523 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.4\" mod_revision:517 > success:<request_put:<key:\"/registry/masterleases/199.204.45.4\" value_size:65 lease:6232309988071097518 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.4\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:33:09.432224Z","caller":"traceutil/trace.go:171","msg":"trace[632549142] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:560; }","duration":"2.692082966s","start":"2026-03-14T01:33:06.740118Z","end":"2026-03-14T01:33:09.432201Z","steps":["trace[632549142] 'read index received'  (duration: 114.652447ms)","trace[632549142] 'applied index is now lower than readState.Index'  (duration: 2.577428859s)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:33:09.43231Z","caller":"traceutil/trace.go:171","msg":"trace[1739900499] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"3.047080611s","start":"2026-03-14T01:33:06.385218Z","end":"2026-03-14T01:33:09.432298Z","steps":["trace[1739900499] 'process raft request'  (duration: 469.54242ms)","trace[1739900499] 'compare'  (duration: 2.577046261s)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:33:09.432371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:06.385203Z","time spent":"3.047133102s","remote":"127.0.0.1:53008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.4\" mod_revision:517 > success:<request_put:<key:\"/registry/masterleases/199.204.45.4\" value_size:65 lease:6232309988071097518 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.4\" > >"}
{"level":"info","ts":"2026-03-14T01:33:09.432682Z","caller":"traceutil/trace.go:171","msg":"trace[618388238] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"3.044942986s","start":"2026-03-14T01:33:06.387729Z","end":"2026-03-14T01:33:09.432672Z","steps":["trace[618388238] 'process raft request'  (duration: 3.044416305s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:09.432736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:06.387715Z","time spent":"3.044990487s","remote":"127.0.0.1:53218","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:532 > 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-03-14T01:33:09.432934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.692824502s","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-03-14T01:33:09.43297Z","caller":"traceutil/trace.go:171","msg":"trace[902560443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:542; }","duration":"2.692905683s","start":"2026-03-14T01:33:06.74005Z","end":"2026-03-14T01:33:09.432956Z","steps":["trace[902560443] 'agreement among raft nodes before linearized reading'  (duration: 2.692794381s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:09.433007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:06.739997Z","time spent":"2.693000805s","remote":"127.0.0.1:53218","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-03-14T01:33:09.508164Z","caller":"traceutil/trace.go:171","msg":"trace[873843094] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"646.119507ms","start":"2026-03-14T01:33:08.862006Z","end":"2026-03-14T01:33:09.508126Z","steps":["trace[873843094] 'process raft request'  (duration: 645.937473ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:09.508324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.118896927s","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-03-14T01:33:09.508338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.990049665s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:33:09.508401Z","caller":"traceutil/trace.go:171","msg":"trace[106701783] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:543; }","duration":"1.11902563s","start":"2026-03-14T01:33:08.389355Z","end":"2026-03-14T01:33:09.50838Z","steps":["trace[106701783] 'agreement among raft nodes before linearized reading'  (duration: 1.118756994s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:09.508342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:08.861978Z","time spent":"646.264471ms","remote":"127.0.0.1:53218","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:520 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-14T01:33:09.508443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:08.389345Z","time spent":"1.119089101s","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-14T01:33:09.508429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.120303407s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-14T01:33:09.508408Z","caller":"traceutil/trace.go:171","msg":"trace[1652908876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:543; }","duration":"1.990185518s","start":"2026-03-14T01:33:07.518207Z","end":"2026-03-14T01:33:09.508393Z","steps":["trace[1652908876] 'agreement among raft nodes before linearized reading'  (duration: 1.990038765s)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:09.508498Z","caller":"traceutil/trace.go:171","msg":"trace[669381042] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:543; }","duration":"1.120427451s","start":"2026-03-14T01:33:08.388052Z","end":"2026-03-14T01:33:09.508479Z","steps":["trace[669381042] 'agreement among raft nodes before linearized reading'  (duration: 1.120164405s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:09.508529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:07.518185Z","time spent":"1.990307171s","remote":"127.0.0.1:52986","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-03-14T01:33:09.508555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:08.388031Z","time spent":"1.120514232s","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-14T01:33:12.14936Z","caller":"traceutil/trace.go:171","msg":"trace[1113712150] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"239.425149ms","start":"2026-03-14T01:33:11.909908Z","end":"2026-03-14T01:33:12.149333Z","steps":["trace[1113712150] 'process raft request'  (duration: 203.841884ms)","trace[1113712150] 'compare'  (duration: 35.489273ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:33:13.082897Z","caller":"traceutil/trace.go:171","msg":"trace[976538145] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"178.436787ms","start":"2026-03-14T01:33:12.904436Z","end":"2026-03-14T01:33:13.082873Z","steps":["trace[976538145] 'process raft request'  (duration: 178.296584ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:15.137751Z","caller":"traceutil/trace.go:171","msg":"trace[1375035698] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"326.998894ms","start":"2026-03-14T01:33:14.810738Z","end":"2026-03-14T01:33:15.137737Z","steps":["trace[1375035698] 'process raft request'  (duration: 326.911312ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:15.137869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:14.810725Z","time spent":"327.075665ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18498,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-zvz6g\" mod_revision:611 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-zvz6g\" value_size:18449 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-zvz6g\" > >"}
{"level":"info","ts":"2026-03-14T01:33:15.137777Z","caller":"traceutil/trace.go:171","msg":"trace[647596870] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:635; }","duration":"235.091976ms","start":"2026-03-14T01:33:14.902665Z","end":"2026-03-14T01:33:15.137757Z","steps":["trace[647596870] 'read index received'  (duration: 235.084556ms)","trace[647596870] 'applied index is now lower than readState.Index'  (duration: 6.01µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:33:15.138013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.331972ms","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-03-14T01:33:15.13818Z","caller":"traceutil/trace.go:171","msg":"trace[291651367] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:614; }","duration":"235.377833ms","start":"2026-03-14T01:33:14.902657Z","end":"2026-03-14T01:33:15.138035Z","steps":["trace[291651367] 'agreement among raft nodes before linearized reading'  (duration: 235.25034ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:23.64143Z","caller":"traceutil/trace.go:171","msg":"trace[189846153] linearizableReadLoop","detail":"{readStateIndex:736; appliedIndex:735; }","duration":"124.888026ms","start":"2026-03-14T01:33:23.516522Z","end":"2026-03-14T01:33:23.64141Z","steps":["trace[189846153] 'read index received'  (duration: 124.694612ms)","trace[189846153] 'applied index is now lower than readState.Index'  (duration: 192.644µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:33:23.641565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.027458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:33:23.641545Z","caller":"traceutil/trace.go:171","msg":"trace[1492048656] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"130.050438ms","start":"2026-03-14T01:33:23.511453Z","end":"2026-03-14T01:33:23.641503Z","steps":["trace[1492048656] 'process raft request'  (duration: 129.777692ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:23.641612Z","caller":"traceutil/trace.go:171","msg":"trace[1801340592] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:711; }","duration":"125.128152ms","start":"2026-03-14T01:33:23.516472Z","end":"2026-03-14T01:33:23.6416Z","steps":["trace[1801340592] 'agreement among raft nodes before linearized reading'  (duration: 125.038269ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:29.812533Z","caller":"traceutil/trace.go:171","msg":"trace[1844502032] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"114.821948ms","start":"2026-03-14T01:33:29.697689Z","end":"2026-03-14T01:33:29.812511Z","steps":["trace[1844502032] 'process raft request'  (duration: 114.319866ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:30.560699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.658357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-14T01:33:30.560818Z","caller":"traceutil/trace.go:171","msg":"trace[2001316831] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:736; }","duration":"254.852852ms","start":"2026-03-14T01:33:30.305938Z","end":"2026-03-14T01:33:30.560791Z","steps":["trace[2001316831] 'count revisions from in-memory index tree'  (duration: 254.556254ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:32.18637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.585605ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071097899 > lease_revoke:<id:567d9ce9f918c544>","response":"size:28"}
{"level":"info","ts":"2026-03-14T01:33:32.186571Z","caller":"traceutil/trace.go:171","msg":"trace[1891186551] linearizableReadLoop","detail":"{readStateIndex:764; appliedIndex:763; }","duration":"451.297851ms","start":"2026-03-14T01:33:31.735233Z","end":"2026-03-14T01:33:32.186531Z","steps":["trace[1891186551] 'read index received'  (duration: 33.391µs)","trace[1891186551] 'applied index is now lower than readState.Index'  (duration: 451.26221ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:33:32.186949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.69538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-14T01:33:32.186987Z","caller":"traceutil/trace.go:171","msg":"trace[872124672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:736; }","duration":"451.789712ms","start":"2026-03-14T01:33:31.735182Z","end":"2026-03-14T01:33:32.186972Z","steps":["trace[872124672] 'agreement among raft nodes before linearized reading'  (duration: 451.543286ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:32.187033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:31.735129Z","time spent":"451.893064ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-14T01:33:32.187032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.597164ms","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-03-14T01:33:32.187081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.0045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-14T01:33:32.187064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.21668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-14T01:33:32.187137Z","caller":"traceutil/trace.go:171","msg":"trace[573882536] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:736; }","duration":"360.767058ms","start":"2026-03-14T01:33:31.826347Z","end":"2026-03-14T01:33:32.187114Z","steps":["trace[573882536] 'agreement among raft nodes before linearized reading'  (duration: 360.444621ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:32.187166Z","caller":"traceutil/trace.go:171","msg":"trace[676386518] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:736; }","duration":"349.156114ms","start":"2026-03-14T01:33:31.837985Z","end":"2026-03-14T01:33:32.187141Z","steps":["trace[676386518] 'agreement among raft nodes before linearized reading'  (duration: 348.868107ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:32.187187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:31.8263Z","time spent":"360.877451ms","remote":"127.0.0.1:53218","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-03-14T01:33:32.187222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:31.837961Z","time spent":"349.250276ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-14T01:33:32.187165Z","caller":"traceutil/trace.go:171","msg":"trace[1377474950] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:736; }","duration":"326.350233ms","start":"2026-03-14T01:33:31.860794Z","end":"2026-03-14T01:33:32.187144Z","steps":["trace[1377474950] 'agreement among raft nodes before linearized reading'  (duration: 326.070876ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:32.187317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:31.860757Z","time spent":"326.547009ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-14T01:33:32.187377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.404129ms","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-03-14T01:33:32.187406Z","caller":"traceutil/trace.go:171","msg":"trace[536357173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:736; }","duration":"349.451911ms","start":"2026-03-14T01:33:31.837946Z","end":"2026-03-14T01:33:32.187398Z","steps":["trace[536357173] 'agreement among raft nodes before linearized reading'  (duration: 349.367419ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:32.187431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:31.837936Z","time spent":"349.490382ms","remote":"127.0.0.1:53218","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-03-14T01:33:32.454327Z","caller":"traceutil/trace.go:171","msg":"trace[2028408248] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"255.543072ms","start":"2026-03-14T01:33:32.198756Z","end":"2026-03-14T01:33:32.454299Z","steps":["trace[2028408248] 'process raft request'  (duration: 255.498101ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:32.454343Z","caller":"traceutil/trace.go:171","msg":"trace[1094916322] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"257.254802ms","start":"2026-03-14T01:33:32.197039Z","end":"2026-03-14T01:33:32.454294Z","steps":["trace[1094916322] 'process raft request'  (duration: 256.875683ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:32.454556Z","caller":"traceutil/trace.go:171","msg":"trace[190959224] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"257.308333ms","start":"2026-03-14T01:33:32.19723Z","end":"2026-03-14T01:33:32.454538Z","steps":["trace[190959224] 'process raft request'  (duration: 256.918364ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:32.454578Z","caller":"traceutil/trace.go:171","msg":"trace[565054387] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"257.179311ms","start":"2026-03-14T01:33:32.197372Z","end":"2026-03-14T01:33:32.454551Z","steps":["trace[565054387] 'process raft request'  (duration: 256.838783ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:46.631245Z","caller":"traceutil/trace.go:171","msg":"trace[880561899] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:811; }","duration":"112.768268ms","start":"2026-03-14T01:33:46.518455Z","end":"2026-03-14T01:33:46.631223Z","steps":["trace[880561899] 'read index received'  (duration: 112.642815ms)","trace[880561899] 'applied index is now lower than readState.Index'  (duration: 124.133µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:33:46.631299Z","caller":"traceutil/trace.go:171","msg":"trace[772443646] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"267.055269ms","start":"2026-03-14T01:33:46.364208Z","end":"2026-03-14T01:33:46.631263Z","steps":["trace[772443646] 'process raft request'  (duration: 266.848724ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:46.631421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.955483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:33:46.631524Z","caller":"traceutil/trace.go:171","msg":"trace[301646839] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:781; }","duration":"113.107186ms","start":"2026-03-14T01:33:46.518387Z","end":"2026-03-14T01:33:46.631494Z","steps":["trace[301646839] 'agreement among raft nodes before linearized reading'  (duration: 112.962153ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:46.658073Z","caller":"traceutil/trace.go:171","msg":"trace[340915667] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"116.991778ms","start":"2026-03-14T01:33:46.541041Z","end":"2026-03-14T01:33:46.658033Z","steps":["trace[340915667] 'process raft request'  (duration: 116.778833ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:46.901256Z","caller":"traceutil/trace.go:171","msg":"trace[1185469038] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"238.824408ms","start":"2026-03-14T01:33:46.662359Z","end":"2026-03-14T01:33:46.901183Z","steps":["trace[1185469038] 'process raft request'  (duration: 155.819616ms)","trace[1185469038] 'compare'  (duration: 82.851239ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:33:46.999117Z","caller":"traceutil/trace.go:171","msg":"trace[664762678] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"335.698745ms","start":"2026-03-14T01:33:46.663367Z","end":"2026-03-14T01:33:46.999066Z","steps":["trace[664762678] 'process raft request'  (duration: 335.49666ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:46.999305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:46.663331Z","time spent":"335.876889ms","remote":"127.0.0.1:53218","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:777 > 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-03-14T01:33:46.9994Z","caller":"traceutil/trace.go:171","msg":"trace[309138695] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"335.729146ms","start":"2026-03-14T01:33:46.66365Z","end":"2026-03-14T01:33:46.999379Z","steps":["trace[309138695] 'process raft request'  (duration: 335.368798ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:46.999534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:46.663638Z","time spent":"335.808229ms","remote":"127.0.0.1:53218","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:778 > 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-03-14T01:33:46.999754Z","caller":"traceutil/trace.go:171","msg":"trace[2049502617] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"335.695046ms","start":"2026-03-14T01:33:46.664048Z","end":"2026-03-14T01:33:46.999743Z","steps":["trace[2049502617] 'process raft request'  (duration: 335.264645ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:46.999819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:46.664033Z","time spent":"335.751198ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:776 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-14T01:33:49.625292Z","caller":"traceutil/trace.go:171","msg":"trace[949019962] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"557.833594ms","start":"2026-03-14T01:33:49.067435Z","end":"2026-03-14T01:33:49.625269Z","steps":["trace[949019962] 'process raft request'  (duration: 557.63367ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:49.625482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:49.067425Z","time spent":"557.967697ms","remote":"127.0.0.1:53218","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:785 > 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-03-14T01:33:49.625499Z","caller":"traceutil/trace.go:171","msg":"trace[1761479187] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"557.905466ms","start":"2026-03-14T01:33:49.067568Z","end":"2026-03-14T01:33:49.625474Z","steps":["trace[1761479187] 'process raft request'  (duration: 557.66037ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:49.625893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:49.067556Z","time spent":"558.225343ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":461,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:786 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-14T01:33:50.800915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.037837ms","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-03-14T01:33:50.800995Z","caller":"traceutil/trace.go:171","msg":"trace[2090097305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:792; }","duration":"140.192302ms","start":"2026-03-14T01:33:50.660782Z","end":"2026-03-14T01:33:50.800974Z","steps":["trace[2090097305] 'range keys from in-memory index tree'  (duration: 139.707599ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:50.800974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.58322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:33:50.801125Z","caller":"traceutil/trace.go:171","msg":"trace[1717814521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:792; }","duration":"281.810805ms","start":"2026-03-14T01:33:50.51928Z","end":"2026-03-14T01:33:50.801091Z","steps":["trace[1717814521] 'range keys from in-memory index tree'  (duration: 281.452506ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:52.365123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.189873ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071098069 > lease_revoke:<id:567d9ce9f918c65d>","response":"size:28"}
{"level":"info","ts":"2026-03-14T01:33:52.365266Z","caller":"traceutil/trace.go:171","msg":"trace[608213938] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:826; }","duration":"735.726397ms","start":"2026-03-14T01:33:51.629519Z","end":"2026-03-14T01:33:52.365246Z","steps":["trace[608213938] 'read index received'  (duration: 121.32711ms)","trace[608213938] 'applied index is now lower than readState.Index'  (duration: 614.397507ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:33:52.365555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.14995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:476"}
{"level":"info","ts":"2026-03-14T01:33:52.365591Z","caller":"traceutil/trace.go:171","msg":"trace[203355231] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:795; }","duration":"734.235122ms","start":"2026-03-14T01:33:51.631343Z","end":"2026-03-14T01:33:52.365578Z","steps":["trace[203355231] 'agreement among raft nodes before linearized reading'  (duration: 734.064208ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:52.365635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:51.631321Z","time spent":"734.305174ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-14T01:33:52.365692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.148117ms","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-03-14T01:33:52.365822Z","caller":"traceutil/trace.go:171","msg":"trace[346188894] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:795; }","duration":"736.371842ms","start":"2026-03-14T01:33:51.629425Z","end":"2026-03-14T01:33:52.365797Z","steps":["trace[346188894] 'agreement among raft nodes before linearized reading'  (duration: 735.926232ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:52.365878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:51.629404Z","time spent":"736.464735ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-14T01:33:52.506453Z","caller":"traceutil/trace.go:171","msg":"trace[1176530052] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"135.686165ms","start":"2026-03-14T01:33:52.370714Z","end":"2026-03-14T01:33:52.506401Z","steps":["trace[1176530052] 'process raft request'  (duration: 135.46614ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:52.539678Z","caller":"traceutil/trace.go:171","msg":"trace[1086186312] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"168.8036ms","start":"2026-03-14T01:33:52.370854Z","end":"2026-03-14T01:33:52.539658Z","steps":["trace[1086186312] 'process raft request'  (duration: 168.601556ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:53.235712Z","caller":"traceutil/trace.go:171","msg":"trace[777975652] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"160.21668ms","start":"2026-03-14T01:33:53.075463Z","end":"2026-03-14T01:33:53.235679Z","steps":["trace[777975652] 'process raft request'  (duration: 159.784629ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:54.494325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.974474ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071098081 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:795 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:33:54.494446Z","caller":"traceutil/trace.go:171","msg":"trace[1252115367] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:831; }","duration":"975.642151ms","start":"2026-03-14T01:33:53.518785Z","end":"2026-03-14T01:33:54.494427Z","steps":["trace[1252115367] 'read index received'  (duration: 356.411061ms)","trace[1252115367] 'applied index is now lower than readState.Index'  (duration: 619.2299ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:33:54.494679Z","caller":"traceutil/trace.go:171","msg":"trace[1792693200] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"1.253929284s","start":"2026-03-14T01:33:53.240737Z","end":"2026-03-14T01:33:54.494667Z","steps":["trace[1792693200] 'process raft request'  (duration: 634.509389ms)","trace[1792693200] 'compare'  (duration: 618.684998ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:33:54.495468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"976.677985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:33:54.49555Z","caller":"traceutil/trace.go:171","msg":"trace[404115516] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"976.767878ms","start":"2026-03-14T01:33:53.518752Z","end":"2026-03-14T01:33:54.495519Z","steps":["trace[404115516] 'agreement among raft nodes before linearized reading'  (duration: 976.677195ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:54.495619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:53.518733Z","time spent":"976.87327ms","remote":"127.0.0.1:52986","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-03-14T01:33:54.495557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:53.240714Z","time spent":"1.254793424s","remote":"127.0.0.1:53218","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:795 > 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-03-14T01:33:54.495868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.422439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-14T01:33:54.495918Z","caller":"traceutil/trace.go:171","msg":"trace[356894187] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:800; }","duration":"191.527472ms","start":"2026-03-14T01:33:54.304377Z","end":"2026-03-14T01:33:54.495905Z","steps":["trace[356894187] 'agreement among raft nodes before linearized reading'  (duration: 191.428229ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:54.495332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.852322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:33:54.495993Z","caller":"traceutil/trace.go:171","msg":"trace[286128949] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:800; }","duration":"425.60582ms","start":"2026-03-14T01:33:54.070356Z","end":"2026-03-14T01:33:54.495961Z","steps":["trace[286128949] 'agreement among raft nodes before linearized reading'  (duration: 424.655417ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:54.496112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:54.070314Z","time spent":"425.756093ms","remote":"127.0.0.1:53334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "}
{"level":"warn","ts":"2026-03-14T01:33:55.021393Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232309988071098085,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-14T01:33:55.522516Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232309988071098085,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-14T01:33:55.58862Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.017733678s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-14T01:33:55.657166Z","caller":"traceutil/trace.go:171","msg":"trace[1497798217] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:832; }","duration":"1.136848945s","start":"2026-03-14T01:33:54.520291Z","end":"2026-03-14T01:33:55.65714Z","steps":["trace[1497798217] 'read index received'  (duration: 1.068480985s)","trace[1497798217] 'applied index is now lower than readState.Index'  (duration: 68.36641ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:33:55.657288Z","caller":"traceutil/trace.go:171","msg":"trace[994480063] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"1.140213063s","start":"2026-03-14T01:33:54.517019Z","end":"2026-03-14T01:33:55.657232Z","steps":["trace[994480063] 'process raft request'  (duration: 1.071830193s)","trace[994480063] 'compare'  (duration: 67.717644ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:33:55.657324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137010248s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-14T01:33:55.657419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.113372075s","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-03-14T01:33:55.657433Z","caller":"traceutil/trace.go:171","msg":"trace[2103905406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:801; }","duration":"1.137189812s","start":"2026-03-14T01:33:54.520217Z","end":"2026-03-14T01:33:55.657407Z","steps":["trace[2103905406] 'agreement among raft nodes before linearized reading'  (duration: 1.137014198s)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:55.657454Z","caller":"traceutil/trace.go:171","msg":"trace[1442209006] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:801; }","duration":"1.113438336s","start":"2026-03-14T01:33:54.544005Z","end":"2026-03-14T01:33:55.657443Z","steps":["trace[1442209006] 'agreement among raft nodes before linearized reading'  (duration: 1.113280172s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:55.657486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:54.52019Z","time spent":"1.137286464s","remote":"127.0.0.1:52986","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-03-14T01:33:55.657543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:54.516999Z","time spent":"1.140422438s","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:796 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-14T01:33:55.657564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.706618ms","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-03-14T01:33:55.65754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.825991ms","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-03-14T01:33:55.657594Z","caller":"traceutil/trace.go:171","msg":"trace[1183582154] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:801; }","duration":"765.806401ms","start":"2026-03-14T01:33:54.89178Z","end":"2026-03-14T01:33:55.657586Z","steps":["trace[1183582154] 'agreement among raft nodes before linearized reading'  (duration: 765.725619ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:55.657625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:54.891749Z","time spent":"765.869173ms","remote":"127.0.0.1:53218","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-03-14T01:33:55.657485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:54.543994Z","time spent":"1.113482357s","remote":"127.0.0.1:53218","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-03-14T01:33:55.657625Z","caller":"traceutil/trace.go:171","msg":"trace[375695097] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:801; }","duration":"415.979424ms","start":"2026-03-14T01:33:55.241626Z","end":"2026-03-14T01:33:55.657605Z","steps":["trace[375695097] 'agreement among raft nodes before linearized reading'  (duration: 415.672907ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:55.657757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:55.241602Z","time spent":"416.145798ms","remote":"127.0.0.1:53218","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-03-14T01:33:55.657807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.273816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-14T01:33:55.657916Z","caller":"traceutil/trace.go:171","msg":"trace[1516440611] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:801; }","duration":"923.415109ms","start":"2026-03-14T01:33:54.73449Z","end":"2026-03-14T01:33:55.657905Z","steps":["trace[1516440611] 'agreement among raft nodes before linearized reading'  (duration: 923.287306ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:55.657949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:33:54.734469Z","time spent":"923.46873ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":2,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "}
{"level":"info","ts":"2026-03-14T01:33:55.8011Z","caller":"traceutil/trace.go:171","msg":"trace[1976692091] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"138.723886ms","start":"2026-03-14T01:33:55.662346Z","end":"2026-03-14T01:33:55.80107Z","steps":["trace[1976692091] 'process raft request'  (duration: 119.307422ms)","trace[1976692091] 'compare'  (duration: 19.271621ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:33:55.860883Z","caller":"traceutil/trace.go:171","msg":"trace[1225771930] linearizableReadLoop","detail":"{readStateIndex:836; appliedIndex:833; }","duration":"193.452087ms","start":"2026-03-14T01:33:55.667413Z","end":"2026-03-14T01:33:55.860865Z","steps":["trace[1225771930] 'read index received'  (duration: 114.181432ms)","trace[1225771930] 'applied index is now lower than readState.Index'  (duration: 79.269225ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:33:55.86096Z","caller":"traceutil/trace.go:171","msg":"trace[1526643923] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"198.035955ms","start":"2026-03-14T01:33:55.662888Z","end":"2026-03-14T01:33:55.860924Z","steps":["trace[1526643923] 'process raft request'  (duration: 197.765598ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:33:55.861121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.650382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:33:55.861165Z","caller":"traceutil/trace.go:171","msg":"trace[1513376597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:804; }","duration":"193.768394ms","start":"2026-03-14T01:33:55.667385Z","end":"2026-03-14T01:33:55.861154Z","steps":["trace[1513376597] 'agreement among raft nodes before linearized reading'  (duration: 193.563779ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:33:55.860795Z","caller":"traceutil/trace.go:171","msg":"trace[1116768206] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"197.84692ms","start":"2026-03-14T01:33:55.662881Z","end":"2026-03-14T01:33:55.860728Z","steps":["trace[1116768206] 'process raft request'  (duration: 197.608445ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:02.148074Z","caller":"traceutil/trace.go:171","msg":"trace[1888758695] linearizableReadLoop","detail":"{readStateIndex:853; appliedIndex:852; }","duration":"245.227188ms","start":"2026-03-14T01:34:01.902825Z","end":"2026-03-14T01:34:02.148052Z","steps":["trace[1888758695] 'read index received'  (duration: 244.972152ms)","trace[1888758695] 'applied index is now lower than readState.Index'  (duration: 253.846µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:34:02.148103Z","caller":"traceutil/trace.go:171","msg":"trace[1626519376] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"452.854248ms","start":"2026-03-14T01:34:01.695227Z","end":"2026-03-14T01:34:02.148081Z","steps":["trace[1626519376] 'process raft request'  (duration: 452.671734ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:02.148272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.451833ms","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-03-14T01:34:02.148269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:01.69521Z","time spent":"452.95361ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:813 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-14T01:34:02.148313Z","caller":"traceutil/trace.go:171","msg":"trace[441341886] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:819; }","duration":"245.588078ms","start":"2026-03-14T01:34:01.902713Z","end":"2026-03-14T01:34:02.148301Z","steps":["trace[441341886] 'agreement among raft nodes before linearized reading'  (duration: 245.462575ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:02.148397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.081632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-14T01:34:02.148443Z","caller":"traceutil/trace.go:171","msg":"trace[1556292694] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:819; }","duration":"238.157023ms","start":"2026-03-14T01:34:01.910274Z","end":"2026-03-14T01:34:02.148431Z","steps":["trace[1556292694] 'agreement among raft nodes before linearized reading'  (duration: 238.056031ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:02.148995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.00671ms","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-03-14T01:34:02.149151Z","caller":"traceutil/trace.go:171","msg":"trace[1168060128] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:819; }","duration":"238.86319ms","start":"2026-03-14T01:34:01.910256Z","end":"2026-03-14T01:34:02.149119Z","steps":["trace[1168060128] 'agreement among raft nodes before linearized reading'  (duration: 237.955439ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:02.339935Z","caller":"traceutil/trace.go:171","msg":"trace[1727799596] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"186.670909ms","start":"2026-03-14T01:34:02.153245Z","end":"2026-03-14T01:34:02.339916Z","steps":["trace[1727799596] 'process raft request'  (duration: 186.600367ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:02.3401Z","caller":"traceutil/trace.go:171","msg":"trace[519471197] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"186.876694ms","start":"2026-03-14T01:34:02.153216Z","end":"2026-03-14T01:34:02.340092Z","steps":["trace[519471197] 'process raft request'  (duration: 154.381893ms)","trace[519471197] 'compare'  (duration: 32.109031ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:34:02.34029Z","caller":"traceutil/trace.go:171","msg":"trace[852843583] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"186.075605ms","start":"2026-03-14T01:34:02.154185Z","end":"2026-03-14T01:34:02.340261Z","steps":["trace[852843583] 'process raft request'  (duration: 185.695426ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:02.657114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.663975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:34:02.657198Z","caller":"traceutil/trace.go:171","msg":"trace[916483207] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:822; }","duration":"138.794899ms","start":"2026-03-14T01:34:02.518382Z","end":"2026-03-14T01:34:02.657177Z","steps":["trace[916483207] 'range keys from in-memory index tree'  (duration: 138.539123ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:02.657193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.807077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-14T01:34:02.657266Z","caller":"traceutil/trace.go:171","msg":"trace[1837098110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:822; }","duration":"108.886428ms","start":"2026-03-14T01:34:02.548347Z","end":"2026-03-14T01:34:02.657233Z","steps":["trace[1837098110] 'range keys from in-memory index tree'  (duration: 108.649523ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:08.953484Z","caller":"traceutil/trace.go:171","msg":"trace[416943254] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"137.850725ms","start":"2026-03-14T01:34:08.815607Z","end":"2026-03-14T01:34:08.953458Z","steps":["trace[416943254] 'process raft request'  (duration: 137.61951ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:09.421088Z","caller":"traceutil/trace.go:171","msg":"trace[38372091] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"124.676317ms","start":"2026-03-14T01:34:09.296378Z","end":"2026-03-14T01:34:09.421054Z","steps":["trace[38372091] 'process raft request'  (duration: 124.454422ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.322821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.380911ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071098248 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" value_size:9570 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:34:10.322925Z","caller":"traceutil/trace.go:171","msg":"trace[1714187926] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"511.794986ms","start":"2026-03-14T01:34:09.811111Z","end":"2026-03-14T01:34:10.322906Z","steps":["trace[1714187926] 'process raft request'  (duration: 275.254811ms)","trace[1714187926] 'compare'  (duration: 236.116955ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:10.322983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:09.811101Z","time spent":"511.859957ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9634,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" value_size:9570 >> failure:<>"}
{"level":"info","ts":"2026-03-14T01:34:10.323365Z","caller":"traceutil/trace.go:171","msg":"trace[1148067212] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"509.459081ms","start":"2026-03-14T01:34:09.813894Z","end":"2026-03-14T01:34:10.323353Z","steps":["trace[1148067212] 'process raft request'  (duration: 509.325848ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.323423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:09.813886Z","time spent":"509.513482ms","remote":"127.0.0.1:53334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":907,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/csidrivers/rbd.csi.ceph.com\" mod_revision:0 > success:<request_put:<key:\"/registry/csidrivers/rbd.csi.ceph.com\" value_size:862 >> failure:<>"}
{"level":"info","ts":"2026-03-14T01:34:10.323508Z","caller":"traceutil/trace.go:171","msg":"trace[1386001292] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"506.233236ms","start":"2026-03-14T01:34:09.817261Z","end":"2026-03-14T01:34:10.323494Z","steps":["trace[1386001292] 'process raft request'  (duration: 506.036722ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.323643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:09.81724Z","time spent":"506.334818ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10711,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-69cb97fb6\" mod_revision:0 > success:<request_put:<key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-69cb97fb6\" value_size:10635 >> failure:<>"}
{"level":"info","ts":"2026-03-14T01:34:10.323381Z","caller":"traceutil/trace.go:171","msg":"trace[213157259] linearizableReadLoop","detail":"{readStateIndex:904; appliedIndex:902; }","duration":"122.366413ms","start":"2026-03-14T01:34:10.20099Z","end":"2026-03-14T01:34:10.323356Z","steps":["trace[213157259] 'read index received'  (duration: 122.167628ms)","trace[213157259] 'applied index is now lower than readState.Index'  (duration: 197.225µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:10.323986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.973688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-14T01:34:10.324069Z","caller":"traceutil/trace.go:171","msg":"trace[1012140374] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:868; }","duration":"123.105471ms","start":"2026-03-14T01:34:10.200938Z","end":"2026-03-14T01:34:10.324044Z","steps":["trace[1012140374] 'agreement among raft nodes before linearized reading'  (duration: 122.837045ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.756129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.431677ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071098252 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:836 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:34:10.756391Z","caller":"traceutil/trace.go:171","msg":"trace[762884021] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"427.262848ms","start":"2026-03-14T01:34:10.3291Z","end":"2026-03-14T01:34:10.756363Z","steps":["trace[762884021] 'process raft request'  (duration: 112.488723ms)","trace[762884021] 'compare'  (duration: 314.264254ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:10.7565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.329073Z","time spent":"427.382932ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:836 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-14T01:34:10.756886Z","caller":"traceutil/trace.go:171","msg":"trace[83612477] linearizableReadLoop","detail":"{readStateIndex:912; appliedIndex:904; }","duration":"360.042105ms","start":"2026-03-14T01:34:10.396826Z","end":"2026-03-14T01:34:10.756868Z","steps":["trace[83612477] 'read index received'  (duration: 44.889831ms)","trace[83612477] 'applied index is now lower than readState.Index'  (duration: 315.151204ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:34:10.756993Z","caller":"traceutil/trace.go:171","msg":"trace[302634930] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"424.222947ms","start":"2026-03-14T01:34:10.33276Z","end":"2026-03-14T01:34:10.756983Z","steps":["trace[302634930] 'process raft request'  (duration: 423.91026ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.757067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.332739Z","time spent":"424.285579ms","remote":"127.0.0.1:53414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9296,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" mod_revision:863 > success:<request_put:<key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" value_size:9232 >> failure:<request_range:<key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" > >"}
{"level":"info","ts":"2026-03-14T01:34:10.757138Z","caller":"traceutil/trace.go:171","msg":"trace[1527925883] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"427.840351ms","start":"2026-03-14T01:34:10.329285Z","end":"2026-03-14T01:34:10.757125Z","steps":["trace[1527925883] 'process raft request'  (duration: 426.953781ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.757216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.329259Z","time spent":"427.920384ms","remote":"127.0.0.1:53050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":747,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner.189c913e5dd91450\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner.189c913e5dd91450\" value_size:659 lease:6232309988071097866 >> failure:<>"}
{"level":"info","ts":"2026-03-14T01:34:10.757316Z","caller":"traceutil/trace.go:171","msg":"trace[832833141] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"413.951446ms","start":"2026-03-14T01:34:10.343317Z","end":"2026-03-14T01:34:10.757268Z","steps":["trace[832833141] 'process raft request'  (duration: 413.486056ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.757439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.621118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-14T01:34:10.757479Z","caller":"traceutil/trace.go:171","msg":"trace[752325278] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:876; }","duration":"360.69662ms","start":"2026-03-14T01:34:10.396768Z","end":"2026-03-14T01:34:10.757465Z","steps":["trace[752325278] 'agreement among raft nodes before linearized reading'  (duration: 360.539356ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.757511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.396746Z","time spent":"360.757862ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-14T01:34:10.757516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.343297Z","time spent":"414.13585ms","remote":"127.0.0.1:53062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":32849,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/kube-system/sh.helm.release.v1.ceph-csi-rbd.v1\" mod_revision:841 > success:<request_put:<key:\"/registry/secrets/kube-system/sh.helm.release.v1.ceph-csi-rbd.v1\" value_size:32775 >> failure:<request_range:<key:\"/registry/secrets/kube-system/sh.helm.release.v1.ceph-csi-rbd.v1\" > >"}
{"level":"info","ts":"2026-03-14T01:34:10.757522Z","caller":"traceutil/trace.go:171","msg":"trace[1341203924] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"427.944373ms","start":"2026-03-14T01:34:10.329543Z","end":"2026-03-14T01:34:10.757487Z","steps":["trace[1341203924] 'process raft request'  (duration: 426.789897ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:10.75771Z","caller":"traceutil/trace.go:171","msg":"trace[147607240] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"423.264645ms","start":"2026-03-14T01:34:10.334431Z","end":"2026-03-14T01:34:10.757696Z","steps":["trace[147607240] 'process raft request'  (duration: 422.309203ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.757716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.329527Z","time spent":"428.079487ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9680,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" mod_revision:866 > success:<request_put:<key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" value_size:9616 >> failure:<request_range:<key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" > >"}
{"level":"warn","ts":"2026-03-14T01:34:10.757754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.334404Z","time spent":"423.325536ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10857,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" mod_revision:865 > success:<request_put:<key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" value_size:10791 >> failure:<request_range:<key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" > >"}
{"level":"warn","ts":"2026-03-14T01:34:10.757801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.314841ms","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-03-14T01:34:10.757841Z","caller":"traceutil/trace.go:171","msg":"trace[257311154] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:876; }","duration":"357.405293ms","start":"2026-03-14T01:34:10.400424Z","end":"2026-03-14T01:34:10.757829Z","steps":["trace[257311154] 'agreement among raft nodes before linearized reading'  (duration: 357.220739ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.75787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.400404Z","time spent":"357.459114ms","remote":"127.0.0.1:53218","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-03-14T01:34:10.757395Z","caller":"traceutil/trace.go:171","msg":"trace[944263168] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"427.955484ms","start":"2026-03-14T01:34:10.329394Z","end":"2026-03-14T01:34:10.75735Z","steps":["trace[944263168] 'process raft request'  (duration: 426.90254ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.757969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.329386Z","time spent":"428.548319ms","remote":"127.0.0.1:53050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":721,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin.189c913e5de0aced\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin.189c913e5de0aced\" value_size:634 lease:6232309988071097866 >> failure:<>"}
{"level":"info","ts":"2026-03-14T01:34:10.75799Z","caller":"traceutil/trace.go:171","msg":"trace[597485215] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"427.454353ms","start":"2026-03-14T01:34:10.330514Z","end":"2026-03-14T01:34:10.757968Z","steps":["trace[597485215] 'process raft request'  (duration: 425.969708ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.758093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.330497Z","time spent":"427.556535ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10713,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tg6b2\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tg6b2\" value_size:10638 >> failure:<>"}
{"level":"warn","ts":"2026-03-14T01:34:10.758159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.776082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:34:10.758195Z","caller":"traceutil/trace.go:171","msg":"trace[731090] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:876; }","duration":"239.839752ms","start":"2026-03-14T01:34:10.518346Z","end":"2026-03-14T01:34:10.758185Z","steps":["trace[731090] 'agreement among raft nodes before linearized reading'  (duration: 239.782611ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.758315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.659657ms","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-03-14T01:34:10.758349Z","caller":"traceutil/trace.go:171","msg":"trace[1741312872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:876; }","duration":"356.733769ms","start":"2026-03-14T01:34:10.401605Z","end":"2026-03-14T01:34:10.758339Z","steps":["trace[1741312872] 'agreement among raft nodes before linearized reading'  (duration: 356.628717ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:10.758379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.401587Z","time spent":"356.78592ms","remote":"127.0.0.1:53218","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-03-14T01:34:11.245424Z","caller":"traceutil/trace.go:171","msg":"trace[817913202] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"480.74781ms","start":"2026-03-14T01:34:10.764651Z","end":"2026-03-14T01:34:11.245399Z","steps":["trace[817913202] 'process raft request'  (duration: 447.201045ms)","trace[817913202] 'compare'  (duration: 33.253857ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:11.245602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.76464Z","time spent":"480.859603ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tg6b2\" mod_revision:873 > success:<request_put:<key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tg6b2\" value_size:10684 >> failure:<request_range:<key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tg6b2\" > >"}
{"level":"info","ts":"2026-03-14T01:34:11.246156Z","caller":"traceutil/trace.go:171","msg":"trace[1894311453] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"475.798724ms","start":"2026-03-14T01:34:10.770262Z","end":"2026-03-14T01:34:11.246061Z","steps":["trace[1894311453] 'process raft request'  (duration: 475.052027ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.24633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.770239Z","time spent":"476.00396ms","remote":"127.0.0.1:53050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":768,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6.189c913e77e4f522\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6.189c913e77e4f522\" value_size:670 lease:6232309988071097866 >> failure:<>"}
{"level":"info","ts":"2026-03-14T01:34:11.246258Z","caller":"traceutil/trace.go:171","msg":"trace[511912094] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"475.61634ms","start":"2026-03-14T01:34:10.770625Z","end":"2026-03-14T01:34:11.246241Z","steps":["trace[511912094] 'process raft request'  (duration: 475.263472ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:11.246395Z","caller":"traceutil/trace.go:171","msg":"trace[1844828169] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"474.850932ms","start":"2026-03-14T01:34:10.771514Z","end":"2026-03-14T01:34:11.246365Z","steps":["trace[1844828169] 'process raft request'  (duration: 474.638237ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.246429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.770611Z","time spent":"475.773764ms","remote":"127.0.0.1:53218","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:818 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-14T01:34:11.246565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.771508Z","time spent":"474.970395ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10828,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-69cb97fb6\" mod_revision:868 > success:<request_put:<key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-69cb97fb6\" value_size:10752 >> failure:<request_range:<key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-69cb97fb6\" > >"}
{"level":"info","ts":"2026-03-14T01:34:11.246778Z","caller":"traceutil/trace.go:171","msg":"trace[1133053137] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"475.154499ms","start":"2026-03-14T01:34:10.771597Z","end":"2026-03-14T01:34:11.246751Z","steps":["trace[1133053137] 'process raft request'  (duration: 474.710329ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.246967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.771592Z","time spent":"475.273262ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:837 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-14T01:34:11.247035Z","caller":"traceutil/trace.go:171","msg":"trace[877887641] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"475.374554ms","start":"2026-03-14T01:34:10.771635Z","end":"2026-03-14T01:34:11.247009Z","steps":["trace[877887641] 'process raft request'  (duration: 475.002806ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:11.247308Z","caller":"traceutil/trace.go:171","msg":"trace[1984532596] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"476.558042ms","start":"2026-03-14T01:34:10.770737Z","end":"2026-03-14T01:34:11.247295Z","steps":["trace[1984532596] 'process raft request'  (duration: 476.177683ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.247388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.77073Z","time spent":"476.617083ms","remote":"127.0.0.1:53218","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:838 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-14T01:34:11.247564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.771631Z","time spent":"475.486858ms","remote":"127.0.0.1:53218","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:839 > 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-03-14T01:34:11.24766Z","caller":"traceutil/trace.go:171","msg":"trace[153511405] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"467.155771ms","start":"2026-03-14T01:34:10.780471Z","end":"2026-03-14T01:34:11.247627Z","steps":["trace[153511405] 'process raft request'  (duration: 466.772393ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:11.247822Z","caller":"traceutil/trace.go:171","msg":"trace[1392704590] linearizableReadLoop","detail":"{readStateIndex:921; appliedIndex:913; }","duration":"406.626415ms","start":"2026-03-14T01:34:10.841178Z","end":"2026-03-14T01:34:11.247804Z","steps":["trace[1392704590] 'read index received'  (duration: 370.49124ms)","trace[1392704590] 'applied index is now lower than readState.Index'  (duration: 36.133245ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:11.247865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.780465Z","time spent":"467.314755ms","remote":"127.0.0.1:53414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9358,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" mod_revision:874 > success:<request_put:<key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" value_size:9294 >> failure:<request_range:<key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" > >"}
{"level":"warn","ts":"2026-03-14T01:34:11.411917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.378387ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071098272 > lease_revoke:<id:567d9ce9f918c6ef>","response":"size:28"}
{"level":"warn","ts":"2026-03-14T01:34:11.412008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.713757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" ","response":"range_response_count:1 size:9695"}
{"level":"info","ts":"2026-03-14T01:34:11.412104Z","caller":"traceutil/trace.go:171","msg":"trace[84408400] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp; range_end:; response_count:1; response_revision:885; }","duration":"641.85475ms","start":"2026-03-14T01:34:10.770222Z","end":"2026-03-14T01:34:11.412077Z","steps":["trace[84408400] 'agreement among raft nodes before linearized reading'  (duration: 477.729059ms)","trace[84408400] 'range keys from in-memory index tree'  (duration: 163.911366ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:11.411995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.953365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:10872"}
{"level":"warn","ts":"2026-03-14T01:34:11.412139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.931556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:6 size:363678"}
{"level":"warn","ts":"2026-03-14T01:34:11.412156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.770205Z","time spent":"641.939372ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":9718,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" "}
{"level":"info","ts":"2026-03-14T01:34:11.41216Z","caller":"traceutil/trace.go:171","msg":"trace[1938763255] linearizableReadLoop","detail":"{readStateIndex:922; appliedIndex:921; }","duration":"164.274034ms","start":"2026-03-14T01:34:11.247868Z","end":"2026-03-14T01:34:11.412142Z","steps":["trace[1938763255] 'read index received'  (duration: 93.792µs)","trace[1938763255] 'applied index is now lower than readState.Index'  (duration: 164.178622ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:34:11.412203Z","caller":"traceutil/trace.go:171","msg":"trace[1504057508] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:885; }","duration":"593.022887ms","start":"2026-03-14T01:34:10.819161Z","end":"2026-03-14T01:34:11.412184Z","steps":["trace[1504057508] 'agreement among raft nodes before linearized reading'  (duration: 428.762753ms)","trace[1504057508] 'range keys from in-memory index tree'  (duration: 163.710062ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:34:11.412208Z","caller":"traceutil/trace.go:171","msg":"trace[494092295] range","detail":"{range_begin:/registry/deployments/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:885; }","duration":"637.19173ms","start":"2026-03-14T01:34:10.774987Z","end":"2026-03-14T01:34:11.412178Z","steps":["trace[494092295] 'agreement among raft nodes before linearized reading'  (duration: 472.954427ms)","trace[494092295] 'range keys from in-memory index tree'  (duration: 163.921756ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:11.412249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.819148Z","time spent":"593.09143ms","remote":"127.0.0.1:53062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":6,"response size":363701,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "}
{"level":"warn","ts":"2026-03-14T01:34:11.412294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.997407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-14T01:34:11.412321Z","caller":"traceutil/trace.go:171","msg":"trace[1317966120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:885; }","duration":"455.078119ms","start":"2026-03-14T01:34:10.957234Z","end":"2026-03-14T01:34:11.412312Z","steps":["trace[1317966120] 'agreement among raft nodes before linearized reading'  (duration: 454.959667ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.412349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.957207Z","time spent":"455.13643ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-14T01:34:11.412289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:10.774979Z","time spent":"637.300563ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":10895,"request content":"key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" "}
{"level":"warn","ts":"2026-03-14T01:34:11.412602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.254595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:751"}
{"level":"info","ts":"2026-03-14T01:34:11.41263Z","caller":"traceutil/trace.go:171","msg":"trace[63302731] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:885; }","duration":"388.309466ms","start":"2026-03-14T01:34:11.024309Z","end":"2026-03-14T01:34:11.412619Z","steps":["trace[63302731] 'agreement among raft nodes before linearized reading'  (duration: 388.239595ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.412656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.024289Z","time spent":"388.362407ms","remote":"127.0.0.1:53156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":774,"request content":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" "}
{"level":"warn","ts":"2026-03-14T01:34:11.412801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.455249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:751"}
{"level":"info","ts":"2026-03-14T01:34:11.412848Z","caller":"traceutil/trace.go:171","msg":"trace[829754804] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:885; }","duration":"388.535991ms","start":"2026-03-14T01:34:11.024295Z","end":"2026-03-14T01:34:11.412831Z","steps":["trace[829754804] 'agreement among raft nodes before linearized reading'  (duration: 388.424509ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.412883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.024272Z","time spent":"388.601833ms","remote":"127.0.0.1:53156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":774,"request content":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" "}
{"level":"info","ts":"2026-03-14T01:34:11.413146Z","caller":"traceutil/trace.go:171","msg":"trace[82160901] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"160.579717ms","start":"2026-03-14T01:34:11.252553Z","end":"2026-03-14T01:34:11.413133Z","steps":["trace[82160901] 'process raft request'  (duration: 159.503882ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:11.577411Z","caller":"traceutil/trace.go:171","msg":"trace[1705746276] linearizableReadLoop","detail":"{readStateIndex:924; appliedIndex:923; }","duration":"162.978974ms","start":"2026-03-14T01:34:11.414404Z","end":"2026-03-14T01:34:11.577383Z","steps":["trace[1705746276] 'read index received'  (duration: 162.409261ms)","trace[1705746276] 'applied index is now lower than readState.Index'  (duration: 568.013µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:34:11.577549Z","caller":"traceutil/trace.go:171","msg":"trace[326377415] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"318.421482ms","start":"2026-03-14T01:34:11.259117Z","end":"2026-03-14T01:34:11.577538Z","steps":["trace[326377415] 'process raft request'  (duration: 317.677765ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.577683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.258837Z","time spent":"318.740319ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10873,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-69cb97fb6\" mod_revision:881 > success:<request_put:<key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-69cb97fb6\" value_size:10797 >> failure:<request_range:<key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-69cb97fb6\" > >"}
{"level":"warn","ts":"2026-03-14T01:34:11.578167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.725321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" ","response":"range_response_count:1 size:9695"}
{"level":"info","ts":"2026-03-14T01:34:11.578272Z","caller":"traceutil/trace.go:171","msg":"trace[1159976679] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp; range_end:; response_count:1; response_revision:887; }","duration":"163.867734ms","start":"2026-03-14T01:34:11.414381Z","end":"2026-03-14T01:34:11.578249Z","steps":["trace[1159976679] 'agreement among raft nodes before linearized reading'  (duration: 163.164598ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:11.937049Z","caller":"traceutil/trace.go:171","msg":"trace[1702990504] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"520.04702ms","start":"2026-03-14T01:34:11.416963Z","end":"2026-03-14T01:34:11.93701Z","steps":["trace[1702990504] 'process raft request'  (duration: 519.647991ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.937414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.936618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" ","response":"range_response_count:1 size:11053"}
{"level":"info","ts":"2026-03-14T01:34:11.937472Z","caller":"traceutil/trace.go:171","msg":"trace[1780297253] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp; range_end:; response_count:1; response_revision:890; }","duration":"523.068041ms","start":"2026-03-14T01:34:11.414392Z","end":"2026-03-14T01:34:11.93746Z","steps":["trace[1780297253] 'agreement among raft nodes before linearized reading'  (duration: 522.865957ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.937508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.414365Z","time spent":"523.133902ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":11076,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" "}
{"level":"warn","ts":"2026-03-14T01:34:11.937708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.416949Z","time spent":"520.480871ms","remote":"127.0.0.1:53218","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:840 > 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-03-14T01:34:11.937092Z","caller":"traceutil/trace.go:171","msg":"trace[410428471] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"510.873045ms","start":"2026-03-14T01:34:11.426181Z","end":"2026-03-14T01:34:11.937054Z","steps":["trace[410428471] 'process raft request'  (duration: 510.724812ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.937912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.739123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:754"}
{"level":"info","ts":"2026-03-14T01:34:11.937946Z","caller":"traceutil/trace.go:171","msg":"trace[1949771297] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:890; }","duration":"510.809114ms","start":"2026-03-14T01:34:11.427127Z","end":"2026-03-14T01:34:11.937936Z","steps":["trace[1949771297] 'agreement among raft nodes before linearized reading'  (duration: 510.682451ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.937985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.427107Z","time spent":"510.870116ms","remote":"127.0.0.1:53156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":777,"request content":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner\" "}
{"level":"warn","ts":"2026-03-14T01:34:11.937967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.743603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:754"}
{"level":"warn","ts":"2026-03-14T01:34:11.938055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.424044Z","time spent":"513.894446ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11038,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" mod_revision:872 > success:<request_put:<key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" value_size:10974 >> failure:<request_range:<key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bg7lp\" > >"}
{"level":"info","ts":"2026-03-14T01:34:11.937214Z","caller":"traceutil/trace.go:171","msg":"trace[1907705802] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"508.734665ms","start":"2026-03-14T01:34:11.428458Z","end":"2026-03-14T01:34:11.937193Z","steps":["trace[1907705802] 'process raft request'  (duration: 508.5206ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.938261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.428397Z","time spent":"509.833101ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11167,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" mod_revision:875 > success:<request_put:<key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" value_size:11101 >> failure:<request_range:<key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" > >"}
{"level":"info","ts":"2026-03-14T01:34:11.937207Z","caller":"traceutil/trace.go:171","msg":"trace[259511077] linearizableReadLoop","detail":"{readStateIndex:927; appliedIndex:924; }","duration":"359.680277ms","start":"2026-03-14T01:34:11.577498Z","end":"2026-03-14T01:34:11.937178Z","steps":["trace[259511077] 'read index received'  (duration: 358.96227ms)","trace[259511077] 'applied index is now lower than readState.Index'  (duration: 715.487µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:34:11.938478Z","caller":"traceutil/trace.go:171","msg":"trace[24280704] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:890; }","duration":"510.906147ms","start":"2026-03-14T01:34:11.427162Z","end":"2026-03-14T01:34:11.938068Z","steps":["trace[24280704] 'agreement among raft nodes before linearized reading'  (duration: 510.455327ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.93857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.427145Z","time spent":"511.408569ms","remote":"127.0.0.1:53156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":777,"request content":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner\" "}
{"level":"warn","ts":"2026-03-14T01:34:11.938552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.529825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:34:11.938636Z","caller":"traceutil/trace.go:171","msg":"trace[3515547] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:890; }","duration":"277.626057ms","start":"2026-03-14T01:34:11.660986Z","end":"2026-03-14T01:34:11.938612Z","steps":["trace[3515547] 'agreement among raft nodes before linearized reading'  (duration: 277.480024ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.938124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.262942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:6 size:363678"}
{"level":"info","ts":"2026-03-14T01:34:11.939085Z","caller":"traceutil/trace.go:171","msg":"trace[887484905] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:890; }","duration":"414.269525ms","start":"2026-03-14T01:34:11.52479Z","end":"2026-03-14T01:34:11.939059Z","steps":["trace[887484905] 'agreement among raft nodes before linearized reading'  (duration: 412.905514ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:11.939328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.524766Z","time spent":"414.49044ms","remote":"127.0.0.1:53062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":6,"response size":363701,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "}
{"level":"warn","ts":"2026-03-14T01:34:12.44805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.212941ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071098286 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-r8sr6\" mod_revision:862 > success:<request_put:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-r8sr6\" value_size:1419 >> failure:<request_range:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-r8sr6\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:34:12.448194Z","caller":"traceutil/trace.go:171","msg":"trace[2111480317] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"498.190409ms","start":"2026-03-14T01:34:11.949983Z","end":"2026-03-14T01:34:12.448173Z","steps":["trace[2111480317] 'process raft request'  (duration: 319.756332ms)","trace[2111480317] 'compare'  (duration: 178.024607ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:12.448261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.949962Z","time spent":"498.267551ms","remote":"127.0.0.1:53222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-r8sr6\" mod_revision:862 > success:<request_put:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-r8sr6\" value_size:1419 >> failure:<request_range:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-r8sr6\" > >"}
{"level":"info","ts":"2026-03-14T01:34:12.453796Z","caller":"traceutil/trace.go:171","msg":"trace[198553615] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"502.501599ms","start":"2026-03-14T01:34:11.95127Z","end":"2026-03-14T01:34:12.453772Z","steps":["trace[198553615] 'process raft request'  (duration: 502.258503ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:12.453976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.951254Z","time spent":"502.626663ms","remote":"127.0.0.1:53144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":913,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" mod_revision:861 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" value_size:828 >> failure:<request_range:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" > >"}
{"level":"info","ts":"2026-03-14T01:34:12.454129Z","caller":"traceutil/trace.go:171","msg":"trace[1884991370] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"502.822026ms","start":"2026-03-14T01:34:11.951287Z","end":"2026-03-14T01:34:12.454109Z","steps":["trace[1884991370] 'process raft request'  (duration: 502.380826ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:12.45495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.951268Z","time spent":"502.911648ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11206,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" mod_revision:890 > success:<request_put:<key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" value_size:11140 >> failure:<request_range:<key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" > >"}
{"level":"info","ts":"2026-03-14T01:34:12.454257Z","caller":"traceutil/trace.go:171","msg":"trace[1243588095] linearizableReadLoop","detail":"{readStateIndex:931; appliedIndex:927; }","duration":"357.126097ms","start":"2026-03-14T01:34:12.097091Z","end":"2026-03-14T01:34:12.454217Z","steps":["trace[1243588095] 'read index received'  (duration: 172.66451ms)","trace[1243588095] 'applied index is now lower than readState.Index'  (duration: 184.460797ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:12.455276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.17162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:34:12.455347Z","caller":"traceutil/trace.go:171","msg":"trace[1176499177] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:894; }","duration":"358.306274ms","start":"2026-03-14T01:34:12.097029Z","end":"2026-03-14T01:34:12.455336Z","steps":["trace[1176499177] 'agreement among raft nodes before linearized reading'  (duration: 357.7331ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:12.45538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:12.097005Z","time spent":"358.366905ms","remote":"127.0.0.1:53232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-03-14T01:34:12.45564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.095236ms","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-03-14T01:34:12.455692Z","caller":"traceutil/trace.go:171","msg":"trace[1304430077] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:894; }","duration":"295.197148ms","start":"2026-03-14T01:34:12.160484Z","end":"2026-03-14T01:34:12.455681Z","steps":["trace[1304430077] 'agreement among raft nodes before linearized reading'  (duration: 294.957562ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:12.456086Z","caller":"traceutil/trace.go:171","msg":"trace[1837384697] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"500.906152ms","start":"2026-03-14T01:34:11.955158Z","end":"2026-03-14T01:34:12.456064Z","steps":["trace[1837384697] 'process raft request'  (duration: 498.863664ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:12.456169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:11.955134Z","time spent":"500.991924ms","remote":"127.0.0.1:53152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12625,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tg6b2\" mod_revision:878 > success:<request_put:<key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tg6b2\" value_size:12550 >> failure:<request_range:<key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tg6b2\" > >"}
{"level":"info","ts":"2026-03-14T01:34:14.069217Z","caller":"traceutil/trace.go:171","msg":"trace[788829428] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"122.945397ms","start":"2026-03-14T01:34:13.946246Z","end":"2026-03-14T01:34:14.069191Z","steps":["trace[788829428] 'process raft request'  (duration: 122.793352ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:16.408376Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232309988071098315,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-14T01:34:16.801934Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.529932832s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-14T01:34:16.802309Z","caller":"traceutil/trace.go:171","msg":"trace[1895925445] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"1.530394632s","start":"2026-03-14T01:34:15.271896Z","end":"2026-03-14T01:34:16.802291Z","steps":["trace[1895925445] 'process raft request'  (duration: 1.530214638s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:16.802436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:15.271872Z","time spent":"1.530494745s","remote":"127.0.0.1:53218","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:902 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-14T01:34:17.509176Z","caller":"traceutil/trace.go:171","msg":"trace[227305091] linearizableReadLoop","detail":"{readStateIndex:944; appliedIndex:942; }","duration":"1.600888873s","start":"2026-03-14T01:34:15.908263Z","end":"2026-03-14T01:34:17.509152Z","steps":["trace[227305091] 'read index received'  (duration: 894.331628ms)","trace[227305091] 'applied index is now lower than readState.Index'  (duration: 706.555985ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:34:17.509284Z","caller":"traceutil/trace.go:171","msg":"trace[945207088] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"2.237179433s","start":"2026-03-14T01:34:15.272095Z","end":"2026-03-14T01:34:17.509274Z","steps":["trace[945207088] 'process raft request'  (duration: 2.236953727s)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:17.509269Z","caller":"traceutil/trace.go:171","msg":"trace[1768640637] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"2.237191334s","start":"2026-03-14T01:34:15.272052Z","end":"2026-03-14T01:34:17.509243Z","steps":["trace[1768640637] 'process raft request'  (duration: 2.22035638s)","trace[1768640637] 'compare'  (duration: 16.244629ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:17.509421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:15.27206Z","time spent":"2.237251055s","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:901 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-14T01:34:17.509476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:15.272022Z","time spent":"2.237311677s","remote":"127.0.0.1:53218","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:900 > 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-03-14T01:34:17.509691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.601400335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"}
{"level":"info","ts":"2026-03-14T01:34:17.509823Z","caller":"traceutil/trace.go:171","msg":"trace[498746118] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:907; }","duration":"1.601535798s","start":"2026-03-14T01:34:15.908212Z","end":"2026-03-14T01:34:17.509747Z","steps":["trace[498746118] 'agreement among raft nodes before linearized reading'  (duration: 1.601104838s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:17.509876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:15.90819Z","time spent":"1.601674041s","remote":"127.0.0.1:53008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.4\" "}
{"level":"info","ts":"2026-03-14T01:34:17.534412Z","caller":"traceutil/trace.go:171","msg":"trace[1964763920] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"271.414631ms","start":"2026-03-14T01:34:17.262957Z","end":"2026-03-14T01:34:17.534372Z","steps":["trace[1964763920] 'process raft request'  (duration: 271.227677ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:17.534434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.295642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-14T01:34:17.53451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.454679263s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-14T01:34:17.534528Z","caller":"traceutil/trace.go:171","msg":"trace[136264177] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:908; }","duration":"369.430285ms","start":"2026-03-14T01:34:17.165081Z","end":"2026-03-14T01:34:17.534511Z","steps":["trace[136264177] 'agreement among raft nodes before linearized reading'  (duration: 369.23574ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:17.534565Z","caller":"traceutil/trace.go:171","msg":"trace[461936978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:908; }","duration":"1.454813986s","start":"2026-03-14T01:34:16.079734Z","end":"2026-03-14T01:34:17.534548Z","steps":["trace[461936978] 'agreement among raft nodes before linearized reading'  (duration: 1.45457919s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:17.53457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:17.165061Z","time spent":"369.497677ms","remote":"127.0.0.1:53472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":23,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "}
{"level":"warn","ts":"2026-03-14T01:34:17.534605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:16.07971Z","time spent":"1.454884117s","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-14T01:34:17.53468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.702032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-14T01:34:17.534712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.0161576s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:34:17.53474Z","caller":"traceutil/trace.go:171","msg":"trace[2126143978] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:908; }","duration":"1.016212251s","start":"2026-03-14T01:34:16.518519Z","end":"2026-03-14T01:34:17.534731Z","steps":["trace[2126143978] 'agreement among raft nodes before linearized reading'  (duration: 1.01616966s)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:17.534737Z","caller":"traceutil/trace.go:171","msg":"trace[655999238] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:908; }","duration":"757.791704ms","start":"2026-03-14T01:34:16.776927Z","end":"2026-03-14T01:34:17.534719Z","steps":["trace[655999238] 'agreement among raft nodes before linearized reading'  (duration: 757.6113ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:17.534763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:16.518502Z","time spent":"1.016257222s","remote":"127.0.0.1:52986","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-03-14T01:34:17.534777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:16.776906Z","time spent":"757.862936ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-14T01:34:25.82882Z","caller":"traceutil/trace.go:171","msg":"trace[1200027467] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"282.248035ms","start":"2026-03-14T01:34:25.546547Z","end":"2026-03-14T01:34:25.828795Z","steps":["trace[1200027467] 'process raft request'  (duration: 233.642968ms)","trace[1200027467] 'compare'  (duration: 48.412072ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:25.829159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.213711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-14T01:34:25.829274Z","caller":"traceutil/trace.go:171","msg":"trace[1521306003] linearizableReadLoop","detail":"{readStateIndex:969; appliedIndex:968; }","duration":"245.829493ms","start":"2026-03-14T01:34:25.58291Z","end":"2026-03-14T01:34:25.82874Z","steps":["trace[1521306003] 'read index received'  (duration: 197.169734ms)","trace[1521306003] 'applied index is now lower than readState.Index'  (duration: 48.658569ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:34:25.829282Z","caller":"traceutil/trace.go:171","msg":"trace[1514165109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:930; }","duration":"246.386766ms","start":"2026-03-14T01:34:25.582871Z","end":"2026-03-14T01:34:25.829257Z","steps":["trace[1514165109] 'agreement among raft nodes before linearized reading'  (duration: 246.006767ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:25.829686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.751331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-14T01:34:25.829776Z","caller":"traceutil/trace.go:171","msg":"trace[879773294] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:930; }","duration":"245.884925ms","start":"2026-03-14T01:34:25.583868Z","end":"2026-03-14T01:34:25.829753Z","steps":["trace[879773294] 'agreement among raft nodes before linearized reading'  (duration: 245.591018ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:26.005131Z","caller":"traceutil/trace.go:171","msg":"trace[615205230] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"170.743545ms","start":"2026-03-14T01:34:25.834355Z","end":"2026-03-14T01:34:26.005098Z","steps":["trace[615205230] 'process raft request'  (duration: 120.95415ms)","trace[615205230] 'compare'  (duration: 49.605081ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:27.98403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.465582ms","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-03-14T01:34:27.984137Z","caller":"traceutil/trace.go:171","msg":"trace[1867116634] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:936; }","duration":"150.644606ms","start":"2026-03-14T01:34:27.833467Z","end":"2026-03-14T01:34:27.984111Z","steps":["trace[1867116634] 'range keys from in-memory index tree'  (duration: 150.117663ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:30.568712Z","caller":"traceutil/trace.go:171","msg":"trace[687301435] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"516.050647ms","start":"2026-03-14T01:34:30.052632Z","end":"2026-03-14T01:34:30.568683Z","steps":["trace[687301435] 'process raft request'  (duration: 453.287708ms)","trace[687301435] 'compare'  (duration: 62.415021ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:30.568878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:30.052612Z","time spent":"516.178259ms","remote":"127.0.0.1:53218","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:939 > 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":"info","ts":"2026-03-14T01:34:33.037134Z","caller":"traceutil/trace.go:171","msg":"trace[1740658059] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"101.804262ms","start":"2026-03-14T01:34:32.935299Z","end":"2026-03-14T01:34:33.037103Z","steps":["trace[1740658059] 'process raft request'  (duration: 37.19915ms)","trace[1740658059] 'compare'  (duration: 64.437188ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:34:33.936588Z","caller":"traceutil/trace.go:171","msg":"trace[388821069] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"351.002084ms","start":"2026-03-14T01:34:33.585559Z","end":"2026-03-14T01:34:33.936561Z","steps":["trace[388821069] 'process raft request'  (duration: 350.83782ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:33.936787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:33.585529Z","time spent":"351.153878ms","remote":"127.0.0.1:53218","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:954 > 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-03-14T01:34:35.91461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.636272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-14T01:34:35.914635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.878154903s","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-03-14T01:34:35.914689Z","caller":"traceutil/trace.go:171","msg":"trace[1571409799] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:972; }","duration":"872.768015ms","start":"2026-03-14T01:34:35.041904Z","end":"2026-03-14T01:34:35.914672Z","steps":["trace[1571409799] 'range keys from in-memory index tree'  (duration: 872.476148ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:35.914712Z","caller":"traceutil/trace.go:171","msg":"trace[1715305445] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:972; }","duration":"1.878273126s","start":"2026-03-14T01:34:34.036417Z","end":"2026-03-14T01:34:35.91469Z","steps":["trace[1715305445] 'range keys from in-memory index tree'  (duration: 1.877970888s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:35.91473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:35.041857Z","time spent":"872.864167ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-14T01:34:35.914756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:34.036398Z","time spent":"1.878350637s","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-14T01:34:35.91493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.855276807s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-14T01:34:35.914968Z","caller":"traceutil/trace.go:171","msg":"trace[1186714276] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:972; }","duration":"1.855340139s","start":"2026-03-14T01:34:34.059617Z","end":"2026-03-14T01:34:35.914957Z","steps":["trace[1186714276] 'range keys from in-memory index tree'  (duration: 1.855182285s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:35.914998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:34.059605Z","time spent":"1.85538735s","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-14T01:34:35.915624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.397136166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:34:35.915726Z","caller":"traceutil/trace.go:171","msg":"trace[1777468932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:972; }","duration":"1.397280039s","start":"2026-03-14T01:34:34.518419Z","end":"2026-03-14T01:34:35.915699Z","steps":["trace[1777468932] 'range keys from in-memory index tree'  (duration: 1.397017323s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:35.915755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.269294954s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-14T01:34:35.915769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:34.518402Z","time spent":"1.397357161s","remote":"127.0.0.1:52986","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-03-14T01:34:35.915773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.296141452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-14T01:34:35.915796Z","caller":"traceutil/trace.go:171","msg":"trace[1101915591] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:972; }","duration":"1.269384316s","start":"2026-03-14T01:34:34.646401Z","end":"2026-03-14T01:34:35.915785Z","steps":["trace[1101915591] 'count revisions from in-memory index tree'  (duration: 1.269139581s)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:35.915815Z","caller":"traceutil/trace.go:171","msg":"trace[1433604750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:972; }","duration":"1.296229654s","start":"2026-03-14T01:34:34.619572Z","end":"2026-03-14T01:34:35.915801Z","steps":["trace[1433604750] 'range keys from in-memory index tree'  (duration: 1.296004079s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:35.915837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:34.646374Z","time spent":"1.269450848s","remote":"127.0.0.1:53144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "}
{"level":"warn","ts":"2026-03-14T01:34:35.915846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:34.619547Z","time spent":"1.296292296s","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-14T01:34:36.077754Z","caller":"traceutil/trace.go:171","msg":"trace[1089446438] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"157.969898ms","start":"2026-03-14T01:34:35.919743Z","end":"2026-03-14T01:34:36.077713Z","steps":["trace[1089446438] 'process raft request'  (duration: 157.527978ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:36.07783Z","caller":"traceutil/trace.go:171","msg":"trace[1072215802] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"157.954687ms","start":"2026-03-14T01:34:35.919867Z","end":"2026-03-14T01:34:36.077822Z","steps":["trace[1072215802] 'process raft request'  (duration: 157.711991ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:36.077752Z","caller":"traceutil/trace.go:171","msg":"trace[1491128083] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"155.415647ms","start":"2026-03-14T01:34:35.922317Z","end":"2026-03-14T01:34:36.077732Z","steps":["trace[1491128083] 'process raft request'  (duration: 155.365846ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:36.077962Z","caller":"traceutil/trace.go:171","msg":"trace[1458180141] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"157.527297ms","start":"2026-03-14T01:34:35.920384Z","end":"2026-03-14T01:34:36.077911Z","steps":["trace[1458180141] 'process raft request'  (duration: 157.262431ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:36.078066Z","caller":"traceutil/trace.go:171","msg":"trace[1544108909] linearizableReadLoop","detail":"{readStateIndex:1019; appliedIndex:1019; }","duration":"122.262892ms","start":"2026-03-14T01:34:35.955743Z","end":"2026-03-14T01:34:36.078006Z","steps":["trace[1544108909] 'read index received'  (duration: 122.226981ms)","trace[1544108909] 'applied index is now lower than readState.Index'  (duration: 18.01µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:36.078314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.800432ms","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-03-14T01:34:36.078388Z","caller":"traceutil/trace.go:171","msg":"trace[877713914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:976; }","duration":"136.947825ms","start":"2026-03-14T01:34:35.941421Z","end":"2026-03-14T01:34:36.078369Z","steps":["trace[877713914] 'agreement among raft nodes before linearized reading'  (duration: 136.699619ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:36.09719Z","caller":"traceutil/trace.go:171","msg":"trace[1308780259] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"140.214781ms","start":"2026-03-14T01:34:35.956953Z","end":"2026-03-14T01:34:36.097168Z","steps":["trace[1308780259] 'process raft request'  (duration: 140.078898ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:36.097905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.038893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:34:36.097991Z","caller":"traceutil/trace.go:171","msg":"trace[2011136944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"133.175827ms","start":"2026-03-14T01:34:35.964794Z","end":"2026-03-14T01:34:36.09797Z","steps":["trace[2011136944] 'agreement among raft nodes before linearized reading'  (duration: 132.968262ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:36.923337Z","caller":"traceutil/trace.go:171","msg":"trace[337740600] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"117.445318ms","start":"2026-03-14T01:34:36.805848Z","end":"2026-03-14T01:34:36.923294Z","steps":["trace[337740600] 'process raft request'  (duration: 78.741762ms)","trace[337740600] 'compare'  (duration: 38.316007ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:34:37.620899Z","caller":"traceutil/trace.go:171","msg":"trace[398878386] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"766.723285ms","start":"2026-03-14T01:34:36.854148Z","end":"2026-03-14T01:34:37.620871Z","steps":["trace[398878386] 'process raft request'  (duration: 766.543121ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:37.621075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:36.854136Z","time spent":"766.849958ms","remote":"127.0.0.1:53050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.189c91448adc2500\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.189c91448adc2500\" value_size:692 lease:6232309988071098429 >> failure:<>"}
{"level":"warn","ts":"2026-03-14T01:34:38.248028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.895089ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071098507 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:982 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:34:38.248226Z","caller":"traceutil/trace.go:171","msg":"trace[29850301] linearizableReadLoop","detail":"{readStateIndex:1028; appliedIndex:1026; }","duration":"730.051879ms","start":"2026-03-14T01:34:37.518152Z","end":"2026-03-14T01:34:38.248204Z","steps":["trace[29850301] 'read index received'  (duration: 102.538071ms)","trace[29850301] 'applied index is now lower than readState.Index'  (duration: 627.511758ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:38.248379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.231444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:34:38.24845Z","caller":"traceutil/trace.go:171","msg":"trace[556442167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:985; }","duration":"730.352647ms","start":"2026-03-14T01:34:37.518085Z","end":"2026-03-14T01:34:38.248438Z","steps":["trace[556442167] 'agreement among raft nodes before linearized reading'  (duration: 730.254534ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:38.248367Z","caller":"traceutil/trace.go:171","msg":"trace[649126525] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"1.320507938s","start":"2026-03-14T01:34:36.927784Z","end":"2026-03-14T01:34:38.248292Z","steps":["trace[649126525] 'process raft request'  (duration: 978.197559ms)","trace[649126525] 'compare'  (duration: 341.398517ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:38.248586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:37.518061Z","time spent":"730.453639ms","remote":"127.0.0.1:52986","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-03-14T01:34:38.248696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:36.927758Z","time spent":"1.320780075s","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:982 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-14T01:34:38.335795Z","caller":"traceutil/trace.go:171","msg":"trace[123882629] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"498.891986ms","start":"2026-03-14T01:34:37.836855Z","end":"2026-03-14T01:34:38.335747Z","steps":["trace[123882629] 'process raft request'  (duration: 498.64216ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:38.33586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.623664ms","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-03-14T01:34:38.335927Z","caller":"traceutil/trace.go:171","msg":"trace[419387262] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:986; }","duration":"252.725906ms","start":"2026-03-14T01:34:38.083183Z","end":"2026-03-14T01:34:38.335909Z","steps":["trace[419387262] 'agreement among raft nodes before linearized reading'  (duration: 252.49242ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:38.335906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.567873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-14T01:34:38.335985Z","caller":"traceutil/trace.go:171","msg":"trace[766580814] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:986; }","duration":"252.682795ms","start":"2026-03-14T01:34:38.083283Z","end":"2026-03-14T01:34:38.335966Z","steps":["trace[766580814] 'agreement among raft nodes before linearized reading'  (duration: 252.407998ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:38.336005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:37.836828Z","time spent":"499.07191ms","remote":"127.0.0.1:53218","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:936 > 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-03-14T01:34:38.336086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.895447ms","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-03-14T01:34:38.336167Z","caller":"traceutil/trace.go:171","msg":"trace[860283982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:986; }","duration":"218.01364ms","start":"2026-03-14T01:34:38.118135Z","end":"2026-03-14T01:34:38.336149Z","steps":["trace[860283982] 'agreement among raft nodes before linearized reading'  (duration: 217.719373ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:38.336124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.983412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-14T01:34:38.336184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.861089ms","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-03-14T01:34:38.336219Z","caller":"traceutil/trace.go:171","msg":"trace[291889311] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:986; }","duration":"252.960312ms","start":"2026-03-14T01:34:38.083249Z","end":"2026-03-14T01:34:38.33621Z","steps":["trace[291889311] 'agreement among raft nodes before linearized reading'  (duration: 252.860889ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:38.336244Z","caller":"traceutil/trace.go:171","msg":"trace[1817870438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:986; }","duration":"253.115395ms","start":"2026-03-14T01:34:38.083095Z","end":"2026-03-14T01:34:38.33621Z","steps":["trace[1817870438] 'agreement among raft nodes before linearized reading'  (duration: 252.958251ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:38.922489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.111871ms","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-03-14T01:34:38.922696Z","caller":"traceutil/trace.go:171","msg":"trace[1425444659] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:986; }","duration":"244.336916ms","start":"2026-03-14T01:34:38.678338Z","end":"2026-03-14T01:34:38.922675Z","steps":["trace[1425444659] 'range keys from in-memory index tree'  (duration: 244.095511ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:38.922761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.557478ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071098512 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:976 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:34:38.922805Z","caller":"traceutil/trace.go:171","msg":"trace[106988796] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"582.132566ms","start":"2026-03-14T01:34:38.340666Z","end":"2026-03-14T01:34:38.922799Z","steps":["trace[106988796] 'process raft request'  (duration: 217.482076ms)","trace[106988796] 'compare'  (duration: 364.348123ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:38.922839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:38.340633Z","time spent":"582.190358ms","remote":"127.0.0.1:53218","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:976 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-14T01:34:38.960043Z","caller":"traceutil/trace.go:171","msg":"trace[911414577] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"619.24903ms","start":"2026-03-14T01:34:38.340761Z","end":"2026-03-14T01:34:38.96001Z","steps":["trace[911414577] 'process raft request'  (duration: 619.024715ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:38.960572Z","caller":"traceutil/trace.go:171","msg":"trace[1012145439] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1029; }","duration":"440.814373ms","start":"2026-03-14T01:34:38.519732Z","end":"2026-03-14T01:34:38.960547Z","steps":["trace[1012145439] 'read index received'  (duration: 38.500136ms)","trace[1012145439] 'applied index is now lower than readState.Index'  (duration: 402.313157ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:34:38.960666Z","caller":"traceutil/trace.go:171","msg":"trace[649019432] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"619.731112ms","start":"2026-03-14T01:34:38.340927Z","end":"2026-03-14T01:34:38.960658Z","steps":["trace[649019432] 'process raft request'  (duration: 619.036505ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:38.960776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:38.340919Z","time spent":"619.781023ms","remote":"127.0.0.1:53218","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:973 > 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":"info","ts":"2026-03-14T01:34:38.960602Z","caller":"traceutil/trace.go:171","msg":"trace[986442626] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"619.573838ms","start":"2026-03-14T01:34:38.341001Z","end":"2026-03-14T01:34:38.960575Z","steps":["trace[986442626] 'process raft request'  (duration: 619.301641ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:38.960899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:38.340981Z","time spent":"619.897615ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:974 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-14T01:34:38.960884Z","caller":"traceutil/trace.go:171","msg":"trace[821756639] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"619.529377ms","start":"2026-03-14T01:34:38.34134Z","end":"2026-03-14T01:34:38.960869Z","steps":["trace[821756639] 'process raft request'  (duration: 619.150728ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:38.961278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:38.341332Z","time spent":"619.707421ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:978 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-14T01:34:38.961698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.760927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-14T01:34:38.961722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.273253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:34:38.961756Z","caller":"traceutil/trace.go:171","msg":"trace[1156170354] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:991; }","duration":"442.068842ms","start":"2026-03-14T01:34:38.519677Z","end":"2026-03-14T01:34:38.961746Z","steps":["trace[1156170354] 'agreement among raft nodes before linearized reading'  (duration: 441.271884ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:38.96175Z","caller":"traceutil/trace.go:171","msg":"trace[1412686737] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:991; }","duration":"302.87791ms","start":"2026-03-14T01:34:38.658858Z","end":"2026-03-14T01:34:38.961736Z","steps":["trace[1412686737] 'agreement among raft nodes before linearized reading'  (duration: 302.732547ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:38.961783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:38.519661Z","time spent":"442.113203ms","remote":"127.0.0.1:52986","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-03-14T01:34:38.961803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:38.658816Z","time spent":"302.976432ms","remote":"127.0.0.1:53062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":6,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "}
{"level":"warn","ts":"2026-03-14T01:34:38.961882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:38.340729Z","time spent":"619.413864ms","remote":"127.0.0.1:53218","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:975 > 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-03-14T01:34:41.410313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.313021ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071098530 > lease_revoke:<id:567d9ce9f918c81a>","response":"size:28"}
{"level":"info","ts":"2026-03-14T01:34:42.602232Z","caller":"traceutil/trace.go:171","msg":"trace[2037916665] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"136.07903ms","start":"2026-03-14T01:34:42.46611Z","end":"2026-03-14T01:34:42.602189Z","steps":["trace[2037916665] 'process raft request'  (duration: 135.841214ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:47.850758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.403772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-03-14T01:34:47.850872Z","caller":"traceutil/trace.go:171","msg":"trace[1908202792] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1048; }","duration":"219.552015ms","start":"2026-03-14T01:34:47.631293Z","end":"2026-03-14T01:34:47.850845Z","steps":["trace[1908202792] 'range keys from in-memory index tree'  (duration: 219.053634ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:48.153893Z","caller":"traceutil/trace.go:171","msg":"trace[364852176] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"296.620681ms","start":"2026-03-14T01:34:47.857239Z","end":"2026-03-14T01:34:48.153859Z","steps":["trace[364852176] 'process raft request'  (duration: 296.404976ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:49.258286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.470025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"}
{"level":"info","ts":"2026-03-14T01:34:49.258402Z","caller":"traceutil/trace.go:171","msg":"trace[166586075] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1049; }","duration":"908.65542ms","start":"2026-03-14T01:34:48.34972Z","end":"2026-03-14T01:34:49.258375Z","steps":["trace[166586075] 'range keys from in-memory index tree'  (duration: 908.153707ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:49.258458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:48.349693Z","time spent":"908.750092ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-14T01:34:49.2585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.66753ms","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-03-14T01:34:49.258637Z","caller":"traceutil/trace.go:171","msg":"trace[667869702] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1049; }","duration":"579.824083ms","start":"2026-03-14T01:34:48.678788Z","end":"2026-03-14T01:34:49.258612Z","steps":["trace[667869702] 'range keys from in-memory index tree'  (duration: 579.646119ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:49.25964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.202208ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071098633 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:986 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:34:49.259785Z","caller":"traceutil/trace.go:171","msg":"trace[1780402942] linearizableReadLoop","detail":"{readStateIndex:1095; appliedIndex:1094; }","duration":"198.942235ms","start":"2026-03-14T01:34:49.060817Z","end":"2026-03-14T01:34:49.25976Z","steps":["trace[1780402942] 'read index received'  (duration: 72.991µs)","trace[1780402942] 'applied index is now lower than readState.Index'  (duration: 198.867694ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:49.260326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.873123ms","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-03-14T01:34:49.260374Z","caller":"traceutil/trace.go:171","msg":"trace[2026363202] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1050; }","duration":"195.997256ms","start":"2026-03-14T01:34:49.064362Z","end":"2026-03-14T01:34:49.26036Z","steps":["trace[2026363202] 'agreement among raft nodes before linearized reading'  (duration: 195.788251ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:49.26035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.49925ms","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:533"}
{"level":"info","ts":"2026-03-14T01:34:49.260492Z","caller":"traceutil/trace.go:171","msg":"trace[1981953173] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1050; }","duration":"199.683895ms","start":"2026-03-14T01:34:49.060762Z","end":"2026-03-14T01:34:49.260446Z","steps":["trace[1981953173] 'agreement among raft nodes before linearized reading'  (duration: 199.257725ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:34:49.260736Z","caller":"traceutil/trace.go:171","msg":"trace[51394252] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"746.637395ms","start":"2026-03-14T01:34:48.514071Z","end":"2026-03-14T01:34:49.260708Z","steps":["trace[51394252] 'process raft request'  (duration: 250.227198ms)","trace[51394252] 'compare'  (duration: 493.767204ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:34:49.260895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:34:48.514039Z","time spent":"746.737777ms","remote":"127.0.0.1:53218","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:986 > 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-03-14T01:34:49.260938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.647764ms","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-03-14T01:34:49.261018Z","caller":"traceutil/trace.go:171","msg":"trace[196317524] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1050; }","duration":"123.751747ms","start":"2026-03-14T01:34:49.13725Z","end":"2026-03-14T01:34:49.261002Z","steps":["trace[196317524] 'agreement among raft nodes before linearized reading'  (duration: 123.557652ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:49.261547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.352615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-14T01:34:49.261587Z","caller":"traceutil/trace.go:171","msg":"trace[209714587] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1050; }","duration":"125.418976ms","start":"2026-03-14T01:34:49.136153Z","end":"2026-03-14T01:34:49.261572Z","steps":["trace[209714587] 'agreement among raft nodes before linearized reading'  (duration: 125.305203ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:49.261791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.834998ms","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-03-14T01:34:49.261853Z","caller":"traceutil/trace.go:171","msg":"trace[1480969776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1050; }","duration":"152.90724ms","start":"2026-03-14T01:34:49.108917Z","end":"2026-03-14T01:34:49.261824Z","steps":["trace[1480969776] 'agreement among raft nodes before linearized reading'  (duration: 152.756116ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:34:49.262117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.330445ms","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-03-14T01:34:49.262152Z","caller":"traceutil/trace.go:171","msg":"trace[1851852092] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1050; }","duration":"194.439518ms","start":"2026-03-14T01:34:49.067702Z","end":"2026-03-14T01:34:49.262142Z","steps":["trace[1851852092] 'agreement among raft nodes before linearized reading'  (duration: 194.296125ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:35:01.441666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.682206ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071098753 > lease_revoke:<id:567d9ce9f918c8e9>","response":"size:28"}
{"level":"info","ts":"2026-03-14T01:35:43.84124Z","caller":"traceutil/trace.go:171","msg":"trace[1173114591] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"167.319391ms","start":"2026-03-14T01:35:43.673893Z","end":"2026-03-14T01:35:43.841212Z","steps":["trace[1173114591] 'process raft request'  (duration: 167.010424ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:35:44.065972Z","caller":"traceutil/trace.go:171","msg":"trace[582260645] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"138.440017ms","start":"2026-03-14T01:35:43.9275Z","end":"2026-03-14T01:35:44.06594Z","steps":["trace[582260645] 'process raft request'  (duration: 87.549023ms)","trace[582260645] 'compare'  (duration: 50.571217ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:35:44.066471Z","caller":"traceutil/trace.go:171","msg":"trace[403637037] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"138.551891ms","start":"2026-03-14T01:35:43.927892Z","end":"2026-03-14T01:35:44.066444Z","steps":["trace[403637037] 'process raft request'  (duration: 137.990037ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:35:44.499013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.799519ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071099219 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1271 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:35:44.499134Z","caller":"traceutil/trace.go:171","msg":"trace[735344102] linearizableReadLoop","detail":"{readStateIndex:1335; appliedIndex:1334; }","duration":"351.42719ms","start":"2026-03-14T01:35:44.147686Z","end":"2026-03-14T01:35:44.499114Z","steps":["trace[735344102] 'read index received'  (duration: 176.440697ms)","trace[735344102] 'applied index is now lower than readState.Index'  (duration: 174.985043ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:35:44.499223Z","caller":"traceutil/trace.go:171","msg":"trace[1290036857] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"428.158768ms","start":"2026-03-14T01:35:44.071052Z","end":"2026-03-14T01:35:44.499211Z","steps":["trace[1290036857] 'process raft request'  (duration: 253.054293ms)","trace[1290036857] 'compare'  (duration: 174.4794ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:35:44.499291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:35:44.071035Z","time spent":"428.223909ms","remote":"127.0.0.1:53218","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:1271 > 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\" > >"}
{"level":"warn","ts":"2026-03-14T01:35:44.499532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.803119ms","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-03-14T01:35:44.500189Z","caller":"traceutil/trace.go:171","msg":"trace[875451151] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1279; }","duration":"352.535356ms","start":"2026-03-14T01:35:44.14763Z","end":"2026-03-14T01:35:44.500165Z","steps":["trace[875451151] 'agreement among raft nodes before linearized reading'  (duration: 351.718317ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:35:44.500245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:35:44.147605Z","time spent":"352.625768ms","remote":"127.0.0.1:53084","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":"info","ts":"2026-03-14T01:35:49.756416Z","caller":"traceutil/trace.go:171","msg":"trace[1739951007] linearizableReadLoop","detail":"{readStateIndex:1355; appliedIndex:1354; }","duration":"111.979531ms","start":"2026-03-14T01:35:49.644406Z","end":"2026-03-14T01:35:49.756386Z","steps":["trace[1739951007] 'read index received'  (duration: 61.317602ms)","trace[1739951007] 'applied index is now lower than readState.Index'  (duration: 50.660759ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:35:49.756658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.215827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-14T01:35:49.756712Z","caller":"traceutil/trace.go:171","msg":"trace[1927582661] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1298; }","duration":"112.32936ms","start":"2026-03-14T01:35:49.644365Z","end":"2026-03-14T01:35:49.756694Z","steps":["trace[1927582661] 'agreement among raft nodes before linearized reading'  (duration: 112.133905ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:35:49.756785Z","caller":"traceutil/trace.go:171","msg":"trace[1823361022] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"148.371953ms","start":"2026-03-14T01:35:49.608392Z","end":"2026-03-14T01:35:49.756764Z","steps":["trace[1823361022] 'process raft request'  (duration: 97.420017ms)","trace[1823361022] 'compare'  (duration: 50.447145ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:35:50.019461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.018654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:35:50.019529Z","caller":"traceutil/trace.go:171","msg":"trace[367446320] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1298; }","duration":"107.162918ms","start":"2026-03-14T01:35:49.91235Z","end":"2026-03-14T01:35:50.019513Z","steps":["trace[367446320] 'count revisions from in-memory index tree'  (duration: 106.873271ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:35:50.019538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.064603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-14T01:35:50.019623Z","caller":"traceutil/trace.go:171","msg":"trace[285565059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1298; }","duration":"139.165815ms","start":"2026-03-14T01:35:49.880439Z","end":"2026-03-14T01:35:50.019605Z","steps":["trace[285565059] 'range keys from in-memory index tree'  (duration: 138.847757ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:35:50.268454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.697722ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071099281 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1292 > 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-03-14T01:35:50.26897Z","caller":"traceutil/trace.go:171","msg":"trace[584825618] linearizableReadLoop","detail":"{readStateIndex:1358; appliedIndex:1356; }","duration":"179.784196ms","start":"2026-03-14T01:35:50.08916Z","end":"2026-03-14T01:35:50.268945Z","steps":["trace[584825618] 'read index received'  (duration: 70.385766ms)","trace[584825618] 'applied index is now lower than readState.Index'  (duration: 109.39729ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:35:50.269043Z","caller":"traceutil/trace.go:171","msg":"trace[995018626] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"245.452311ms","start":"2026-03-14T01:35:50.023551Z","end":"2026-03-14T01:35:50.269003Z","steps":["trace[995018626] 'process raft request'  (duration: 136.077652ms)","trace[995018626] 'compare'  (duration: 108.503208ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:35:50.269074Z","caller":"traceutil/trace.go:171","msg":"trace[2099935469] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"245.482212ms","start":"2026-03-14T01:35:50.023555Z","end":"2026-03-14T01:35:50.269038Z","steps":["trace[2099935469] 'process raft request'  (duration: 245.301808ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:35:50.269215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.290185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-14T01:35:50.269209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.047103ms","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-03-14T01:35:50.269268Z","caller":"traceutil/trace.go:171","msg":"trace[969025373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1301; }","duration":"179.377377ms","start":"2026-03-14T01:35:50.089875Z","end":"2026-03-14T01:35:50.269252Z","steps":["trace[969025373] 'agreement among raft nodes before linearized reading'  (duration: 179.236094ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:35:50.269334Z","caller":"traceutil/trace.go:171","msg":"trace[290028271] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1301; }","duration":"180.201776ms","start":"2026-03-14T01:35:50.089117Z","end":"2026-03-14T01:35:50.269319Z","steps":["trace[290028271] 'agreement among raft nodes before linearized reading'  (duration: 179.95737ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:35:50.574863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.996599ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071099285 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1293 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:35:50.575188Z","caller":"traceutil/trace.go:171","msg":"trace[300791265] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"300.146346ms","start":"2026-03-14T01:35:50.275004Z","end":"2026-03-14T01:35:50.57515Z","steps":["trace[300791265] 'process raft request'  (duration: 177.740118ms)","trace[300791265] 'compare'  (duration: 121.848535ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:35:50.5754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:35:50.274973Z","time spent":"300.33041ms","remote":"127.0.0.1:53218","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:1293 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-14T01:35:50.575518Z","caller":"traceutil/trace.go:171","msg":"trace[1901098272] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"300.461824ms","start":"2026-03-14T01:35:50.275046Z","end":"2026-03-14T01:35:50.575508Z","steps":["trace[1901098272] 'process raft request'  (duration: 299.944452ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:35:50.575572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:35:50.275021Z","time spent":"300.519294ms","remote":"127.0.0.1:53218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1294 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-14T01:35:50.575707Z","caller":"traceutil/trace.go:171","msg":"trace[310816303] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"228.194002ms","start":"2026-03-14T01:35:50.347491Z","end":"2026-03-14T01:35:50.575685Z","steps":["trace[310816303] 'process raft request'  (duration: 227.814033ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:36:14.630461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.630016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:36:14.630574Z","caller":"traceutil/trace.go:171","msg":"trace[1678028813] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1399; }","duration":"112.79534ms","start":"2026-03-14T01:36:14.517738Z","end":"2026-03-14T01:36:14.630533Z","steps":["trace[1678028813] 'range keys from in-memory index tree'  (duration: 112.537564ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:36:18.951313Z","caller":"traceutil/trace.go:171","msg":"trace[1233362591] transaction","detail":"{read_only:false; response_revision:1418; number_of_response:1; }","duration":"116.437886ms","start":"2026-03-14T01:36:18.834834Z","end":"2026-03-14T01:36:18.951272Z","steps":["trace[1233362591] 'process raft request'  (duration: 53.037336ms)","trace[1233362591] 'compare'  (duration: 63.036222ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:36:25.028818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.427602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"}
{"level":"info","ts":"2026-03-14T01:36:25.028922Z","caller":"traceutil/trace.go:171","msg":"trace[306753985] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1441; }","duration":"202.585636ms","start":"2026-03-14T01:36:24.826313Z","end":"2026-03-14T01:36:25.028898Z","steps":["trace[306753985] 'range keys from in-memory index tree'  (duration: 202.226238ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:36:28.548238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.15998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-03-14T01:36:28.548323Z","caller":"traceutil/trace.go:171","msg":"trace[582676513] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1454; }","duration":"105.290362ms","start":"2026-03-14T01:36:28.443012Z","end":"2026-03-14T01:36:28.548303Z","steps":["trace[582676513] 'range keys from in-memory index tree'  (duration: 104.958064ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:36:31.629474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.395318ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071099714 > lease_revoke:<id:567d9ce9f918cc9b>","response":"size:28"}
{"level":"info","ts":"2026-03-14T01:36:31.62999Z","caller":"traceutil/trace.go:171","msg":"trace[1959099956] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"212.063219ms","start":"2026-03-14T01:36:31.417879Z","end":"2026-03-14T01:36:31.629942Z","steps":["trace[1959099956] 'process raft request'  (duration: 211.805183ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:37:12.820516Z","caller":"traceutil/trace.go:171","msg":"trace[1180477537] transaction","detail":"{read_only:false; response_revision:1635; number_of_response:1; }","duration":"155.164601ms","start":"2026-03-14T01:37:12.665309Z","end":"2026-03-14T01:37:12.820474Z","steps":["trace[1180477537] 'process raft request'  (duration: 154.914135ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:37:21.117181Z","caller":"traceutil/trace.go:171","msg":"trace[1394117870] transaction","detail":"{read_only:false; response_revision:1669; number_of_response:1; }","duration":"203.503913ms","start":"2026-03-14T01:37:20.913642Z","end":"2026-03-14T01:37:21.117146Z","steps":["trace[1394117870] 'process raft request'  (duration: 160.988143ms)","trace[1394117870] 'compare'  (duration: 42.207661ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:37:21.190873Z","caller":"traceutil/trace.go:171","msg":"trace[1020900979] linearizableReadLoop","detail":"{readStateIndex:1745; appliedIndex:1743; }","duration":"227.341584ms","start":"2026-03-14T01:37:20.963496Z","end":"2026-03-14T01:37:21.190838Z","steps":["trace[1020900979] 'read index received'  (duration: 111.133725ms)","trace[1020900979] 'applied index is now lower than readState.Index'  (duration: 116.206309ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:37:21.191161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.646192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-03-14T01:37:21.191242Z","caller":"traceutil/trace.go:171","msg":"trace[2010324433] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1669; }","duration":"227.777554ms","start":"2026-03-14T01:37:20.963442Z","end":"2026-03-14T01:37:21.19122Z","steps":["trace[2010324433] 'agreement among raft nodes before linearized reading'  (duration: 227.531028ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:37:23.049882Z","caller":"traceutil/trace.go:171","msg":"trace[1689356837] transaction","detail":"{read_only:false; response_revision:1677; number_of_response:1; }","duration":"115.118543ms","start":"2026-03-14T01:37:22.934733Z","end":"2026-03-14T01:37:23.049851Z","steps":["trace[1689356837] 'process raft request'  (duration: 69.660583ms)","trace[1689356837] 'compare'  (duration: 45.335247ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:37:23.425967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.265448ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6232309988071100262 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1669 > 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-03-14T01:37:23.426086Z","caller":"traceutil/trace.go:171","msg":"trace[1708604228] linearizableReadLoop","detail":"{readStateIndex:1754; appliedIndex:1753; }","duration":"241.210023ms","start":"2026-03-14T01:37:23.184858Z","end":"2026-03-14T01:37:23.426068Z","steps":["trace[1708604228] 'read index received'  (duration: 14.680158ms)","trace[1708604228] 'applied index is now lower than readState.Index'  (duration: 226.528485ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:37:23.42619Z","caller":"traceutil/trace.go:171","msg":"trace[1874072945] transaction","detail":"{read_only:false; response_revision:1678; number_of_response:1; }","duration":"301.301292ms","start":"2026-03-14T01:37:23.124854Z","end":"2026-03-14T01:37:23.426155Z","steps":["trace[1874072945] 'process raft request'  (duration: 74.740767ms)","trace[1874072945] 'compare'  (duration: 226.125175ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:37:23.426282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.125371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-14T01:37:23.426322Z","caller":"traceutil/trace.go:171","msg":"trace[1923441017] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1678; }","duration":"189.210094ms","start":"2026-03-14T01:37:23.237099Z","end":"2026-03-14T01:37:23.426309Z","steps":["trace[1923441017] 'agreement among raft nodes before linearized reading'  (duration: 189.151573ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:37:23.426222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.368148ms","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-03-14T01:37:23.426406Z","caller":"traceutil/trace.go:171","msg":"trace[989723121] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1678; }","duration":"241.591903ms","start":"2026-03-14T01:37:23.184795Z","end":"2026-03-14T01:37:23.426387Z","steps":["trace[989723121] 'agreement among raft nodes before linearized reading'  (duration: 241.366707ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:37:23.426419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.298679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-14T01:37:23.426489Z","caller":"traceutil/trace.go:171","msg":"trace[1319857857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1678; }","duration":"183.416012ms","start":"2026-03-14T01:37:23.243054Z","end":"2026-03-14T01:37:23.42647Z","steps":["trace[1319857857] 'agreement among raft nodes before linearized reading'  (duration: 183.221717ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:37:23.426731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:37:23.12483Z","time spent":"301.450296ms","remote":"127.0.0.1:53218","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:1669 > 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-03-14T01:37:23.664342Z","caller":"traceutil/trace.go:171","msg":"trace[447142757] linearizableReadLoop","detail":"{readStateIndex:1755; appliedIndex:1754; }","duration":"207.042739ms","start":"2026-03-14T01:37:23.457272Z","end":"2026-03-14T01:37:23.664315Z","steps":["trace[447142757] 'read index received'  (duration: 193.138849ms)","trace[447142757] 'applied index is now lower than readState.Index'  (duration: 13.90278ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:37:23.664408Z","caller":"traceutil/trace.go:171","msg":"trace[1608553832] transaction","detail":"{read_only:false; response_revision:1679; number_of_response:1; }","duration":"233.351342ms","start":"2026-03-14T01:37:23.431017Z","end":"2026-03-14T01:37:23.664368Z","steps":["trace[1608553832] 'process raft request'  (duration: 219.382131ms)","trace[1608553832] 'compare'  (duration: 13.785066ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:37:23.664584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.293465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-03-14T01:37:23.664625Z","caller":"traceutil/trace.go:171","msg":"trace[932429937] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1679; }","duration":"207.394458ms","start":"2026-03-14T01:37:23.45722Z","end":"2026-03-14T01:37:23.664615Z","steps":["trace[932429937] 'agreement among raft nodes before linearized reading'  (duration: 207.218934ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:37:23.66459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.761532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-14T01:37:23.664693Z","caller":"traceutil/trace.go:171","msg":"trace[997333202] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1679; }","duration":"206.902855ms","start":"2026-03-14T01:37:23.457778Z","end":"2026-03-14T01:37:23.664681Z","steps":["trace[997333202] 'agreement among raft nodes before linearized reading'  (duration: 206.727231ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:37:23.664688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.969462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-03-14T01:37:23.664844Z","caller":"traceutil/trace.go:171","msg":"trace[533580799] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1679; }","duration":"127.166567ms","start":"2026-03-14T01:37:23.537667Z","end":"2026-03-14T01:37:23.664834Z","steps":["trace[533580799] 'agreement among raft nodes before linearized reading'  (duration: 126.933572ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:37:27.199999Z","caller":"traceutil/trace.go:171","msg":"trace[968589038] transaction","detail":"{read_only:false; response_revision:1695; number_of_response:1; }","duration":"131.168846ms","start":"2026-03-14T01:37:27.068798Z","end":"2026-03-14T01:37:27.199967Z","steps":["trace[968589038] 'process raft request'  (duration: 131.016932ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:37:29.823442Z","caller":"traceutil/trace.go:171","msg":"trace[1755402853] linearizableReadLoop","detail":"{readStateIndex:1782; appliedIndex:1781; }","duration":"100.276989ms","start":"2026-03-14T01:37:29.723143Z","end":"2026-03-14T01:37:29.82342Z","steps":["trace[1755402853] 'read index received'  (duration: 100.041364ms)","trace[1755402853] 'applied index is now lower than readState.Index'  (duration: 234.875µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:37:29.823874Z","caller":"traceutil/trace.go:171","msg":"trace[494765104] transaction","detail":"{read_only:false; response_revision:1705; number_of_response:1; }","duration":"109.721272ms","start":"2026-03-14T01:37:29.714123Z","end":"2026-03-14T01:37:29.823844Z","steps":["trace[494765104] 'process raft request'  (duration: 109.142838ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:37:29.823928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.754873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-03-14T01:37:29.824017Z","caller":"traceutil/trace.go:171","msg":"trace[1386934112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1705; }","duration":"100.887725ms","start":"2026-03-14T01:37:29.723107Z","end":"2026-03-14T01:37:29.823994Z","steps":["trace[1386934112] 'agreement among raft nodes before linearized reading'  (duration: 100.547437ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:38:00.179079Z","caller":"traceutil/trace.go:171","msg":"trace[417401881] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"171.827136ms","start":"2026-03-14T01:38:00.007218Z","end":"2026-03-14T01:38:00.179045Z","steps":["trace[417401881] 'process raft request'  (duration: 93.231103ms)","trace[417401881] 'compare'  (duration: 78.066281ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:38:00.552399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.345305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"}
{"level":"info","ts":"2026-03-14T01:38:00.552508Z","caller":"traceutil/trace.go:171","msg":"trace[1120876025] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1852; }","duration":"272.496858ms","start":"2026-03-14T01:38:00.279985Z","end":"2026-03-14T01:38:00.552481Z","steps":["trace[1120876025] 'range keys from in-memory index tree'  (duration: 272.13218ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:38:17.783869Z","caller":"traceutil/trace.go:171","msg":"trace[425331269] linearizableReadLoop","detail":"{readStateIndex:2019; appliedIndex:2018; }","duration":"227.263024ms","start":"2026-03-14T01:38:17.556583Z","end":"2026-03-14T01:38:17.783846Z","steps":["trace[425331269] 'read index received'  (duration: 227.049019ms)","trace[425331269] 'applied index is now lower than readState.Index'  (duration: 212.995µs)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:38:17.784037Z","caller":"traceutil/trace.go:171","msg":"trace[2135584044] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"227.650254ms","start":"2026-03-14T01:38:17.556315Z","end":"2026-03-14T01:38:17.783965Z","steps":["trace[2135584044] 'process raft request'  (duration: 227.391378ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:38:17.784067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.467369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-14T01:38:17.784342Z","caller":"traceutil/trace.go:171","msg":"trace[1289292774] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1931; }","duration":"227.775217ms","start":"2026-03-14T01:38:17.556525Z","end":"2026-03-14T01:38:17.7843Z","steps":["trace[1289292774] 'agreement among raft nodes before linearized reading'  (duration: 227.454819ms)"],"step_count":1}