{"level":"warn","ts":"2026-02-06T00:45:39.088429Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-06T00:45:39.088508Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-02-06T00:45:39.088569Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-06T00:45:39.088577Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]}
{"level":"info","ts":"2026-02-06T00:45:39.088596Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-06T00:45:39.089308Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]}
{"level":"info","ts":"2026-02-06T00:45:39.089381Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-02-06T00:45:39.094234Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.6149ms"}
{"level":"info","ts":"2026-02-06T00:45:39.107186Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"}
{"level":"info","ts":"2026-02-06T00:45:39.107231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-06T00:45:39.107287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"}
{"level":"info","ts":"2026-02-06T00:45:39.107301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-06T00:45:39.107307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"}
{"level":"info","ts":"2026-02-06T00:45:39.107433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"}
{"level":"warn","ts":"2026-02-06T00:45:39.117584Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-06T00:45:39.118951Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-06T00:45:39.120072Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-02-06T00:45:39.12187Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-06T00:45:39.124274Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-06T00:45:39.124367Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-06T00:45:39.124395Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-06T00:45:39.124407Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-06T00:45:39.125256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"}
{"level":"info","ts":"2026-02-06T00:45:39.130346Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-06T00:45:39.130479Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-06T00:45:39.130499Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-06T00:45:39.130574Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]}
{"level":"info","ts":"2026-02-06T00:45:39.130623Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"}
{"level":"info","ts":"2026-02-06T00:45:39.130631Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"}
{"level":"info","ts":"2026-02-06T00:45:39.211237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-06T00:45:39.211278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-06T00:45:39.211299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"}
{"level":"info","ts":"2026-02-06T00:45:39.21131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"}
{"level":"info","ts":"2026-02-06T00:45:39.211318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"}
{"level":"info","ts":"2026-02-06T00:45:39.211327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"}
{"level":"info","ts":"2026-02-06T00:45:39.211343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"}
{"level":"info","ts":"2026-02-06T00:45:39.216181Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-06T00:45:39.216256Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-06T00:45:39.216528Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-06T00:45:39.216615Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-06T00:45:39.216736Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-06T00:45:39.216749Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-06T00:45:39.219449Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"}
{"level":"info","ts":"2026-02-06T00:45:39.219975Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-06T00:45:39.220025Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-06T00:45:39.220039Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-06T00:45:39.221995Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-06T00:45:42.040374Z","caller":"traceutil/trace.go:171","msg":"trace[2130135338] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"353.390953ms","start":"2026-02-06T00:45:41.68696Z","end":"2026-02-06T00:45:42.040351Z","steps":["trace[2130135338] 'process raft request'  (duration: 353.198468ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:42.041424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.68695Z","time spent":"353.891394ms","remote":"127.0.0.1:54260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/ranges/serviceips\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/serviceips\" value_size:67 >> failure:<request_range:<key:\"/registry/ranges/serviceips\" > >"}
{"level":"warn","ts":"2026-02-06T00:45:42.040785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.650821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:42.041773Z","caller":"traceutil/trace.go:171","msg":"trace[1229375059] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:2; }","duration":"352.669706ms","start":"2026-02-06T00:45:41.689091Z","end":"2026-02-06T00:45:42.041761Z","steps":["trace[1229375059] 'agreement among raft nodes before linearized reading'  (duration: 351.534448ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:42.041815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.689085Z","time spent":"352.721007ms","remote":"127.0.0.1:54264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/servicenodeports\" "}
{"level":"info","ts":"2026-02-06T00:45:42.040524Z","caller":"traceutil/trace.go:171","msg":"trace[330697763] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:5; }","duration":"351.377415ms","start":"2026-02-06T00:45:41.689105Z","end":"2026-02-06T00:45:42.040483Z","steps":["trace[330697763] 'read index received'  (duration: 351.369975ms)","trace[330697763] 'applied index is now lower than readState.Index'  (duration: 5.82µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:45:42.542909Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148899994903424,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-06T00:45:43.043664Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148899994903424,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-06T00:45:43.190656Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.150295502s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-06T00:45:43.539262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.250531ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994903416 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-06T00:45:43.539612Z","caller":"traceutil/trace.go:171","msg":"trace[491876688] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.806489964s","start":"2026-02-06T00:45:41.733103Z","end":"2026-02-06T00:45:43.539593Z","steps":["trace[491876688] 'process raft request'  (duration: 1.806450893s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.539692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.733097Z","time spent":"1.806558856s","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-6wz8d\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-6wz8d\" value_size:795 >> failure:<>"}
{"level":"info","ts":"2026-02-06T00:45:43.54007Z","caller":"traceutil/trace.go:171","msg":"trace[1409080072] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.840222046s","start":"2026-02-06T00:45:41.699836Z","end":"2026-02-06T00:45:43.540058Z","steps":["trace[1409080072] 'process raft request'  (duration: 1.491000022s)","trace[1409080072] 'compare'  (duration: 348.104907ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:45:43.540127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.699826Z","time spent":"1.840280508s","remote":"127.0.0.1:54638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>"}
{"level":"info","ts":"2026-02-06T00:45:43.540361Z","caller":"traceutil/trace.go:171","msg":"trace[288730490] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.816549914s","start":"2026-02-06T00:45:41.723801Z","end":"2026-02-06T00:45:43.540351Z","steps":["trace[288730490] 'process raft request'  (duration: 1.81554863s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.540426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.723783Z","time spent":"1.816613965s","remote":"127.0.0.1:54700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" value_size:827 >> failure:<>"}
{"level":"info","ts":"2026-02-06T00:45:43.540549Z","caller":"traceutil/trace.go:171","msg":"trace[1736376882] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.816648227s","start":"2026-02-06T00:45:41.723893Z","end":"2026-02-06T00:45:43.540541Z","steps":["trace[1736376882] 'process raft request'  (duration: 1.815502969s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.540593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.723889Z","time spent":"1.816687958s","remote":"127.0.0.1:54700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" value_size:860 >> failure:<>"}
{"level":"info","ts":"2026-02-06T00:45:43.540711Z","caller":"traceutil/trace.go:171","msg":"trace[629621940] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.81680917s","start":"2026-02-06T00:45:41.723894Z","end":"2026-02-06T00:45:43.540703Z","steps":["trace[629621940] 'process raft request'  (duration: 1.81554712s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.540755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.723884Z","time spent":"1.816854881s","remote":"127.0.0.1:54700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>"}
{"level":"info","ts":"2026-02-06T00:45:43.54086Z","caller":"traceutil/trace.go:171","msg":"trace[1088482826] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.816926173s","start":"2026-02-06T00:45:41.723926Z","end":"2026-02-06T00:45:43.540852Z","steps":["trace[1088482826] 'process raft request'  (duration: 1.81555137s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.540903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.723922Z","time spent":"1.816964554s","remote":"127.0.0.1:54700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" value_size:892 >> failure:<>"}
{"level":"info","ts":"2026-02-06T00:45:43.541024Z","caller":"traceutil/trace.go:171","msg":"trace[1457671215] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.816843001s","start":"2026-02-06T00:45:41.724171Z","end":"2026-02-06T00:45:43.541014Z","steps":["trace[1457671215] 'process raft request'  (duration: 1.815333844s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.541076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.724165Z","time spent":"1.816892632s","remote":"127.0.0.1:54700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" value_size:894 >> failure:<>"}
{"level":"info","ts":"2026-02-06T00:45:43.542952Z","caller":"traceutil/trace.go:171","msg":"trace[1753894284] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.815263363s","start":"2026-02-06T00:45:41.72768Z","end":"2026-02-06T00:45:43.542943Z","steps":["trace[1753894284] 'process raft request'  (duration: 1.811848941s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.543024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.727674Z","time spent":"1.815334465s","remote":"127.0.0.1:54388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2846,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:2812 >> failure:<>"}
{"level":"info","ts":"2026-02-06T00:45:43.699303Z","caller":"traceutil/trace.go:171","msg":"trace[1360529411] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:5; }","duration":"1.657174543s","start":"2026-02-06T00:45:42.042106Z","end":"2026-02-06T00:45:43.69928Z","steps":["trace[1360529411] 'read index received'  (duration: 1.148738364s)","trace[1360529411] 'applied index is now lower than readState.Index'  (duration: 508.435259ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:45:43.699324Z","caller":"traceutil/trace.go:171","msg":"trace[421164121] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.656306913s","start":"2026-02-06T00:45:42.042974Z","end":"2026-02-06T00:45:43.699281Z","steps":["trace[421164121] 'process raft request'  (duration: 1.650675759s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.699587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.949272229s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.699712Z","caller":"traceutil/trace.go:171","msg":"trace[436289524] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.949407963s","start":"2026-02-06T00:45:41.750293Z","end":"2026-02-06T00:45:43.6997Z","steps":["trace[436289524] 'agreement among raft nodes before linearized reading'  (duration: 1.94926409s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.699781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.750286Z","time spent":"1.949484565s","remote":"127.0.0.1:54310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-02-06T00:45:43.700197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.958481179s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.70023Z","caller":"traceutil/trace.go:171","msg":"trace[625586431] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.958527359s","start":"2026-02-06T00:45:41.741693Z","end":"2026-02-06T00:45:43.70022Z","steps":["trace[625586431] 'agreement among raft nodes before linearized reading'  (duration: 1.958464808s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.700257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.741688Z","time spent":"1.95856317s","remote":"127.0.0.1:54310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-02-06T00:45:43.700389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.962804241s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.700413Z","caller":"traceutil/trace.go:171","msg":"trace[1209149909] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.962844683s","start":"2026-02-06T00:45:41.737561Z","end":"2026-02-06T00:45:43.700406Z","steps":["trace[1209149909] 'agreement among raft nodes before linearized reading'  (duration: 1.962805832s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.700436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.737553Z","time spent":"1.962878423s","remote":"127.0.0.1:54310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-02-06T00:45:43.700545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.965311841s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.700571Z","caller":"traceutil/trace.go:171","msg":"trace[1518653335] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.965347412s","start":"2026-02-06T00:45:41.735217Z","end":"2026-02-06T00:45:43.700564Z","steps":["trace[1518653335] 'agreement among raft nodes before linearized reading'  (duration: 1.965306821s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.700594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.735211Z","time spent":"1.965377483s","remote":"127.0.0.1:54310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-02-06T00:45:43.700694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.002048414s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.700723Z","caller":"traceutil/trace.go:171","msg":"trace[1855556226] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.002108676s","start":"2026-02-06T00:45:41.698601Z","end":"2026-02-06T00:45:43.70071Z","steps":["trace[1855556226] 'agreement among raft nodes before linearized reading'  (duration: 2.002078085s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.700764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.698598Z","time spent":"2.002150177s","remote":"127.0.0.1:54310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-02-06T00:45:43.700865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.002335321s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.700891Z","caller":"traceutil/trace.go:171","msg":"trace[1306746417] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"2.002378922s","start":"2026-02-06T00:45:41.698502Z","end":"2026-02-06T00:45:43.700881Z","steps":["trace[1306746417] 'agreement among raft nodes before linearized reading'  (duration: 2.002345521s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.700916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.698496Z","time spent":"2.002413684s","remote":"127.0.0.1:54280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"warn","ts":"2026-02-06T00:45:43.701031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.004559814s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.701055Z","caller":"traceutil/trace.go:171","msg":"trace[1119178846] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:0; response_revision:11; }","duration":"2.004592425s","start":"2026-02-06T00:45:41.696455Z","end":"2026-02-06T00:45:43.701047Z","steps":["trace[1119178846] 'agreement among raft nodes before linearized reading'  (duration: 2.004550914s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.701078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.696449Z","time spent":"2.004624026s","remote":"127.0.0.1:54222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.19\" "}
{"level":"warn","ts":"2026-02-06T00:45:43.701697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:42.042955Z","time spent":"1.656623821s","remote":"127.0.0.1:54264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/ranges/servicenodeports\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/servicenodeports\" value_size:66 >> failure:<request_range:<key:\"/registry/ranges/servicenodeports\" > >"}
{"level":"warn","ts":"2026-02-06T00:45:43.701819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.012565864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:2858"}
{"level":"info","ts":"2026-02-06T00:45:43.701861Z","caller":"traceutil/trace.go:171","msg":"trace[347415116] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"2.012651546s","start":"2026-02-06T00:45:41.6892Z","end":"2026-02-06T00:45:43.701851Z","steps":["trace[347415116] 'agreement among raft nodes before linearized reading'  (duration: 2.012464531s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.701943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.68919Z","time spent":"2.012743778s","remote":"127.0.0.1:54388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":2881,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-02-06T00:45:43.699508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.91946172s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.702363Z","caller":"traceutil/trace.go:171","msg":"trace[843928263] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"1.92234228s","start":"2026-02-06T00:45:41.78001Z","end":"2026-02-06T00:45:43.702352Z","steps":["trace[843928263] 'agreement among raft nodes before linearized reading'  (duration: 1.919367759s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.702441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:41.780004Z","time spent":"1.922420202s","remote":"127.0.0.1:54310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "}
{"level":"warn","ts":"2026-02-06T00:45:43.703216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106707035s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.703322Z","caller":"traceutil/trace.go:171","msg":"trace[595910000] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:18; }","duration":"1.106816598s","start":"2026-02-06T00:45:42.596498Z","end":"2026-02-06T00:45:43.703314Z","steps":["trace[595910000] 'agreement among raft nodes before linearized reading'  (duration: 1.106673164s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.703439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:42.596441Z","time spent":"1.106969411s","remote":"127.0.0.1:54548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "}
{"level":"info","ts":"2026-02-06T00:45:43.704387Z","caller":"traceutil/trace.go:171","msg":"trace[1894500086] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"151.363229ms","start":"2026-02-06T00:45:43.553013Z","end":"2026-02-06T00:45:43.704376Z","steps":["trace[1894500086] 'process raft request'  (duration: 149.811122ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:43.704955Z","caller":"traceutil/trace.go:171","msg":"trace[1207825315] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"151.713687ms","start":"2026-02-06T00:45:43.55307Z","end":"2026-02-06T00:45:43.704784Z","steps":["trace[1207825315] 'process raft request'  (duration: 149.853234ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:43.706279Z","caller":"traceutil/trace.go:171","msg":"trace[1312466603] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"152.908135ms","start":"2026-02-06T00:45:43.553212Z","end":"2026-02-06T00:45:43.70612Z","steps":["trace[1312466603] 'process raft request'  (duration: 149.840753ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:43.706822Z","caller":"traceutil/trace.go:171","msg":"trace[553653846] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"153.473509ms","start":"2026-02-06T00:45:43.55327Z","end":"2026-02-06T00:45:43.706743Z","steps":["trace[553653846] 'process raft request'  (duration: 149.829183ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:43.708553Z","caller":"traceutil/trace.go:171","msg":"trace[1327546398] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"153.784656ms","start":"2026-02-06T00:45:43.553302Z","end":"2026-02-06T00:45:43.707087Z","steps":["trace[1327546398] 'process raft request'  (duration: 149.818432ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:43.709644Z","caller":"traceutil/trace.go:171","msg":"trace[270009901] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"156.329427ms","start":"2026-02-06T00:45:43.553297Z","end":"2026-02-06T00:45:43.709627Z","steps":["trace[270009901] 'process raft request'  (duration: 149.837853ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:43.709866Z","caller":"traceutil/trace.go:171","msg":"trace[96299956] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"156.493981ms","start":"2026-02-06T00:45:43.553359Z","end":"2026-02-06T00:45:43.709853Z","steps":["trace[96299956] 'process raft request'  (duration: 149.789462ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.710188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.682778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-6wz8d\" ","response":"range_response_count:1 size:861"}
{"level":"info","ts":"2026-02-06T00:45:43.710321Z","caller":"traceutil/trace.go:171","msg":"trace[1686803623] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-6wz8d; range_end:; response_count:1; response_revision:18; }","duration":"162.806831ms","start":"2026-02-06T00:45:43.547478Z","end":"2026-02-06T00:45:43.710285Z","steps":["trace[1686803623] 'agreement among raft nodes before linearized reading'  (duration: 162.602926ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.710738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.352433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.710811Z","caller":"traceutil/trace.go:171","msg":"trace[681764601] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18; }","duration":"623.460755ms","start":"2026-02-06T00:45:43.087339Z","end":"2026-02-06T00:45:43.7108Z","steps":["trace[681764601] 'agreement among raft nodes before linearized reading'  (duration: 623.27543ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.710902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:43.08731Z","time spent":"623.585577ms","remote":"127.0.0.1:54204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-06T00:45:43.711661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.113775103s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.711741Z","caller":"traceutil/trace.go:171","msg":"trace[1669406658] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:18; }","duration":"1.113865605s","start":"2026-02-06T00:45:42.597865Z","end":"2026-02-06T00:45:43.71173Z","steps":["trace[1669406658] 'agreement among raft nodes before linearized reading'  (duration: 1.113781443s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.71182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:45:42.597856Z","time spent":"1.113950378s","remote":"127.0.0.1:54558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "}
{"level":"info","ts":"2026-02-06T00:45:43.892412Z","caller":"traceutil/trace.go:171","msg":"trace[190096350] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"124.356396ms","start":"2026-02-06T00:45:43.768034Z","end":"2026-02-06T00:45:43.892391Z","steps":["trace[190096350] 'process raft request'  (duration: 124.306175ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:43.892719Z","caller":"traceutil/trace.go:171","msg":"trace[1087899802] linearizableReadLoop","detail":"{readStateIndex:45; appliedIndex:44; }","duration":"133.007862ms","start":"2026-02-06T00:45:43.759701Z","end":"2026-02-06T00:45:43.892709Z","steps":["trace[1087899802] 'read index received'  (duration: 124.53249ms)","trace[1087899802] 'applied index is now lower than readState.Index'  (duration: 8.474592ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:45:43.892421Z","caller":"traceutil/trace.go:171","msg":"trace[891055256] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"137.251104ms","start":"2026-02-06T00:45:43.755151Z","end":"2026-02-06T00:45:43.892402Z","steps":["trace[891055256] 'process raft request'  (duration: 129.072919ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.894083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.363545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.894974Z","caller":"traceutil/trace.go:171","msg":"trace[1774360820] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:0; response_revision:42; }","duration":"135.277046ms","start":"2026-02-06T00:45:43.759685Z","end":"2026-02-06T00:45:43.894962Z","steps":["trace[1774360820] 'agreement among raft nodes before linearized reading'  (duration: 134.329154ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.89543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.733464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/default/\" range_end:\"/registry/resourcequotas/default0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.895534Z","caller":"traceutil/trace.go:171","msg":"trace[1813909257] range","detail":"{range_begin:/registry/resourcequotas/default/; range_end:/registry/resourcequotas/default0; response_count:0; response_revision:42; }","duration":"134.858407ms","start":"2026-02-06T00:45:43.760665Z","end":"2026-02-06T00:45:43.895524Z","steps":["trace[1813909257] 'agreement among raft nodes before linearized reading'  (duration: 134.725293ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:45:43.895771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.830805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-06T00:45:43.896064Z","caller":"traceutil/trace.go:171","msg":"trace[1703494782] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:42; }","duration":"116.123582ms","start":"2026-02-06T00:45:43.779932Z","end":"2026-02-06T00:45:43.896056Z","steps":["trace[1703494782] 'agreement among raft nodes before linearized reading'  (duration: 115.818665ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:45:58.492159Z","caller":"traceutil/trace.go:171","msg":"trace[938856371] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"167.43259ms","start":"2026-02-06T00:45:58.324704Z","end":"2026-02-06T00:45:58.492136Z","steps":["trace[938856371] 'process raft request'  (duration: 98.668665ms)","trace[938856371] 'compare'  (duration: 68.310985ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:46:01.921795Z","caller":"traceutil/trace.go:171","msg":"trace[1468271400] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"137.412475ms","start":"2026-02-06T00:46:01.784357Z","end":"2026-02-06T00:46:01.921769Z","steps":["trace[1468271400] 'process raft request'  (duration: 120.285841ms)","trace[1468271400] 'compare'  (duration: 16.93358ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:46:09.351812Z","caller":"traceutil/trace.go:171","msg":"trace[211797998] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"150.177062ms","start":"2026-02-06T00:46:09.201608Z","end":"2026-02-06T00:46:09.351785Z","steps":["trace[211797998] 'process raft request'  (duration: 149.741982ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:46:10.108195Z","caller":"traceutil/trace.go:171","msg":"trace[1963232914] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"357.886797ms","start":"2026-02-06T00:46:09.750292Z","end":"2026-02-06T00:46:10.108179Z","steps":["trace[1963232914] 'process raft request'  (duration: 357.862447ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:10.108292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:09.750284Z","time spent":"357.961689ms","remote":"127.0.0.1:54398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14860,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-dvg7x\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-dvg7x\" value_size:14813 >> failure:<>"}
{"level":"info","ts":"2026-02-06T00:46:10.109196Z","caller":"traceutil/trace.go:171","msg":"trace[549027890] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"362.632014ms","start":"2026-02-06T00:46:09.746551Z","end":"2026-02-06T00:46:10.109183Z","steps":["trace[549027890] 'process raft request'  (duration: 361.518889ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:46:10.109297Z","caller":"traceutil/trace.go:171","msg":"trace[1522412492] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"363.082294ms","start":"2026-02-06T00:46:09.746206Z","end":"2026-02-06T00:46:10.109288Z","steps":["trace[1522412492] 'process raft request'  (duration: 361.760554ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:10.109341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:09.746164Z","time spent":"363.157836ms","remote":"127.0.0.1:54398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3554,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-7htv7\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-7htv7\" value_size:3487 >> failure:<>"}
{"level":"warn","ts":"2026-02-06T00:46:10.10949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:09.746534Z","time spent":"362.772647ms","remote":"127.0.0.1:54648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4298,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/cilium-operator\" mod_revision:479 > success:<request_put:<key:\"/registry/deployments/kube-system/cilium-operator\" value_size:4241 >> failure:<request_range:<key:\"/registry/deployments/kube-system/cilium-operator\" > >"}
{"level":"info","ts":"2026-02-06T00:46:10.125267Z","caller":"traceutil/trace.go:171","msg":"trace[845392448] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"336.974338ms","start":"2026-02-06T00:46:09.788279Z","end":"2026-02-06T00:46:10.125253Z","steps":["trace[845392448] 'process raft request'  (duration: 333.917179ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:10.125511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:09.788248Z","time spent":"337.07628ms","remote":"127.0.0.1:54292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317259,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" mod_revision:468 > success:<request_put:<key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" value_size:317191 >> failure:<request_range:<key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" > >"}
{"level":"info","ts":"2026-02-06T00:46:10.126852Z","caller":"traceutil/trace.go:171","msg":"trace[480971003] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:501; }","duration":"317.710335ms","start":"2026-02-06T00:46:09.809118Z","end":"2026-02-06T00:46:10.126828Z","steps":["trace[480971003] 'read index received'  (duration: 300.052288ms)","trace[480971003] 'applied index is now lower than readState.Index'  (duration: 17.589475ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:46:10.12871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.589797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-06T00:46:10.128756Z","caller":"traceutil/trace.go:171","msg":"trace[269832686] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:490; }","duration":"319.662169ms","start":"2026-02-06T00:46:09.809087Z","end":"2026-02-06T00:46:10.128749Z","steps":["trace[269832686] 'agreement among raft nodes before linearized reading'  (duration: 319.190529ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:10.128824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:09.809074Z","time spent":"319.74401ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-06T00:46:10.133302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.320488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-06T00:46:10.145284Z","caller":"traceutil/trace.go:171","msg":"trace[555159214] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:492; }","duration":"175.346998ms","start":"2026-02-06T00:46:09.969904Z","end":"2026-02-06T00:46:10.145251Z","steps":["trace[555159214] 'agreement among raft nodes before linearized reading'  (duration: 163.362018ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:10.134177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.098672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:46:10.145735Z","caller":"traceutil/trace.go:171","msg":"trace[2115029055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:492; }","duration":"129.668241ms","start":"2026-02-06T00:46:10.016061Z","end":"2026-02-06T00:46:10.145729Z","steps":["trace[2115029055] 'agreement among raft nodes before linearized reading'  (duration: 118.103371ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:10.134219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.128327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-06T00:46:10.145987Z","caller":"traceutil/trace.go:171","msg":"trace[363665648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:492; }","duration":"135.950223ms","start":"2026-02-06T00:46:10.010031Z","end":"2026-02-06T00:46:10.145981Z","steps":["trace[363665648] 'agreement among raft nodes before linearized reading'  (duration: 124.173038ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:12.670232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.528734ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994904400 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:498 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:46:12.670292Z","caller":"traceutil/trace.go:171","msg":"trace[778352203] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:524; }","duration":"480.978902ms","start":"2026-02-06T00:46:12.189303Z","end":"2026-02-06T00:46:12.670282Z","steps":["trace[778352203] 'read index received'  (duration: 84.316115ms)","trace[778352203] 'applied index is now lower than readState.Index'  (duration: 396.662237ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:46:12.670342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.037104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-06T00:46:12.670355Z","caller":"traceutil/trace.go:171","msg":"trace[946595478] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:508; }","duration":"481.059794ms","start":"2026-02-06T00:46:12.189289Z","end":"2026-02-06T00:46:12.670349Z","steps":["trace[946595478] 'agreement among raft nodes before linearized reading'  (duration: 481.017453ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:12.670371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:12.189284Z","time spent":"481.082864ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-06T00:46:12.670512Z","caller":"traceutil/trace.go:171","msg":"trace[767096040] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"482.001654ms","start":"2026-02-06T00:46:12.188505Z","end":"2026-02-06T00:46:12.670506Z","steps":["trace[767096040] 'process raft request'  (duration: 85.150163ms)","trace[767096040] 'compare'  (duration: 396.464133ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:46:12.670551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:12.188495Z","time spent":"482.028976ms","remote":"127.0.0.1:54470","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:498 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-06T00:46:13.255418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.59562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-06T00:46:13.25547Z","caller":"traceutil/trace.go:171","msg":"trace[481788032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:509; }","duration":"300.690931ms","start":"2026-02-06T00:46:12.954766Z","end":"2026-02-06T00:46:13.255457Z","steps":["trace[481788032] 'range keys from in-memory index tree'  (duration: 300.468137ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:13.255497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:12.954748Z","time spent":"300.743093ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-06T00:46:13.255734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.282376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:46:13.255782Z","caller":"traceutil/trace.go:171","msg":"trace[393942517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:509; }","duration":"240.353517ms","start":"2026-02-06T00:46:13.015415Z","end":"2026-02-06T00:46:13.255768Z","steps":["trace[393942517] 'range keys from in-memory index tree'  (duration: 240.245916ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:14.811711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.372105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-06T00:46:14.811776Z","caller":"traceutil/trace.go:171","msg":"trace[519942332] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:512; }","duration":"137.508968ms","start":"2026-02-06T00:46:14.674246Z","end":"2026-02-06T00:46:14.811755Z","steps":["trace[519942332] 'range keys from in-memory index tree'  (duration: 137.242621ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:15.513346Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148899994904412,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-06T00:46:15.673302Z","caller":"traceutil/trace.go:171","msg":"trace[1429532769] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"858.619812ms","start":"2026-02-06T00:46:14.814668Z","end":"2026-02-06T00:46:15.673288Z","steps":["trace[1429532769] 'process raft request'  (duration: 858.52663ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:15.67341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:14.814654Z","time spent":"858.692833ms","remote":"127.0.0.1:54470","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:508 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-06T00:46:15.694864Z","caller":"traceutil/trace.go:171","msg":"trace[1507132792] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:530; }","duration":"682.380495ms","start":"2026-02-06T00:46:15.012467Z","end":"2026-02-06T00:46:15.694848Z","steps":["trace[1507132792] 'read index received'  (duration: 661.815693ms)","trace[1507132792] 'applied index is now lower than readState.Index'  (duration: 20.561922ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:46:15.694931Z","caller":"traceutil/trace.go:171","msg":"trace[1468873998] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"879.285347ms","start":"2026-02-06T00:46:14.81564Z","end":"2026-02-06T00:46:15.694925Z","steps":["trace[1468873998] 'process raft request'  (duration: 879.121493ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:15.695017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:14.815624Z","time spent":"879.338948ms","remote":"127.0.0.1:54470","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:509 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-06T00:46:15.695024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.325339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-06T00:46:15.695047Z","caller":"traceutil/trace.go:171","msg":"trace[1481074700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:514; }","duration":"428.39911ms","start":"2026-02-06T00:46:15.26664Z","end":"2026-02-06T00:46:15.69504Z","steps":["trace[1481074700] 'agreement among raft nodes before linearized reading'  (duration: 428.324309ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:15.695063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:15.26662Z","time spent":"428.439312ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-06T00:46:15.695106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.639211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:46:15.695116Z","caller":"traceutil/trace.go:171","msg":"trace[1322083698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:514; }","duration":"682.670951ms","start":"2026-02-06T00:46:15.012442Z","end":"2026-02-06T00:46:15.695113Z","steps":["trace[1322083698] 'agreement among raft nodes before linearized reading'  (duration: 682.654631ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:15.695127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:15.012429Z","time spent":"682.695561ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-06T00:46:15.695208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.565856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-06T00:46:15.695221Z","caller":"traceutil/trace.go:171","msg":"trace[1583094450] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:514; }","duration":"270.578616ms","start":"2026-02-06T00:46:15.424639Z","end":"2026-02-06T00:46:15.695217Z","steps":["trace[1583094450] 'agreement among raft nodes before linearized reading'  (duration: 270.552796ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:15.695268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.466518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:46:15.695289Z","caller":"traceutil/trace.go:171","msg":"trace[1083110075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:514; }","duration":"349.512209ms","start":"2026-02-06T00:46:15.345771Z","end":"2026-02-06T00:46:15.695283Z","steps":["trace[1083110075] 'agreement among raft nodes before linearized reading'  (duration: 349.479318ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:15.695305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:15.345758Z","time spent":"349.54201ms","remote":"127.0.0.1:54204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-06T00:46:17.922103Z","caller":"traceutil/trace.go:171","msg":"trace[829653455] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"196.311458ms","start":"2026-02-06T00:46:17.725769Z","end":"2026-02-06T00:46:17.922081Z","steps":["trace[829653455] 'process raft request'  (duration: 196.158215ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:46:17.938676Z","caller":"traceutil/trace.go:171","msg":"trace[1070332254] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"212.099714ms","start":"2026-02-06T00:46:17.726562Z","end":"2026-02-06T00:46:17.938661Z","steps":["trace[1070332254] 'process raft request'  (duration: 212.040182ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:18.157176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.149067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:46:18.157251Z","caller":"traceutil/trace.go:171","msg":"trace[1966488106] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"140.613468ms","start":"2026-02-06T00:46:18.016619Z","end":"2026-02-06T00:46:18.157233Z","steps":["trace[1966488106] 'range keys from in-memory index tree'  (duration: 140.084936ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:46:18.157736Z","caller":"traceutil/trace.go:171","msg":"trace[2016283514] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"127.024922ms","start":"2026-02-06T00:46:18.0307Z","end":"2026-02-06T00:46:18.157725Z","steps":["trace[2016283514] 'process raft request'  (duration: 126.903509ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:18.918776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.159943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-06T00:46:18.918848Z","caller":"traceutil/trace.go:171","msg":"trace[664070079] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:521; }","duration":"635.264526ms","start":"2026-02-06T00:46:18.283565Z","end":"2026-02-06T00:46:18.91883Z","steps":["trace[664070079] 'range keys from in-memory index tree'  (duration: 635.083162ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:18.918886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:18.283548Z","time spent":"635.329007ms","remote":"127.0.0.1:54470","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-02-06T00:46:22.238565Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148899994904456,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-06T00:46:22.599894Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.181056114s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-06T00:46:22.600211Z","caller":"traceutil/trace.go:171","msg":"trace[749769547] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:548; }","duration":"861.670882ms","start":"2026-02-06T00:46:21.738512Z","end":"2026-02-06T00:46:22.600183Z","steps":["trace[749769547] 'read index received'  (duration: 861.487818ms)","trace[749769547] 'applied index is now lower than readState.Index'  (duration: 182.264µs)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:46:22.600323Z","caller":"traceutil/trace.go:171","msg":"trace[1670072578] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"1.181581226s","start":"2026-02-06T00:46:21.418735Z","end":"2026-02-06T00:46:22.600316Z","steps":["trace[1670072578] 'process raft request'  (duration: 1.18133393s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:22.600398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:21.418723Z","time spent":"1.181620386s","remote":"127.0.0.1:54398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-dvg7x\" mod_revision:502 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-dvg7x\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-dvg7x\" > >"}
{"level":"warn","ts":"2026-02-06T00:46:22.600501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.988448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-06T00:46:22.60052Z","caller":"traceutil/trace.go:171","msg":"trace[445690832] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:530; }","duration":"862.04205ms","start":"2026-02-06T00:46:21.738472Z","end":"2026-02-06T00:46:22.600514Z","steps":["trace[445690832] 'agreement among raft nodes before linearized reading'  (duration: 862.004639ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:22.600539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:21.738435Z","time spent":"862.099451ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-06T00:46:22.600717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.096989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-02-06T00:46:22.600733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.196925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:46:22.600755Z","caller":"traceutil/trace.go:171","msg":"trace[747310293] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:530; }","duration":"586.219365ms","start":"2026-02-06T00:46:22.01453Z","end":"2026-02-06T00:46:22.600749Z","steps":["trace[747310293] 'agreement among raft nodes before linearized reading'  (duration: 586.188384ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:22.600772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:22.01446Z","time spent":"586.308136ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-06T00:46:22.600763Z","caller":"traceutil/trace.go:171","msg":"trace[523726922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:530; }","duration":"658.182081ms","start":"2026-02-06T00:46:21.942564Z","end":"2026-02-06T00:46:22.600746Z","steps":["trace[523726922] 'agreement among raft nodes before linearized reading'  (duration: 658.101479ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:22.600805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:21.942544Z","time spent":"658.250893ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-06T00:46:22.600948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.46273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-06T00:46:22.60097Z","caller":"traceutil/trace.go:171","msg":"trace[1372885285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:530; }","duration":"598.522282ms","start":"2026-02-06T00:46:22.002442Z","end":"2026-02-06T00:46:22.600964Z","steps":["trace[1372885285] 'agreement among raft nodes before linearized reading'  (duration: 598.481711ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:22.600988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:22.002395Z","time spent":"598.587303ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-06T00:46:25.140128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.604545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:46:25.140218Z","caller":"traceutil/trace.go:171","msg":"trace[1957514216] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:545; }","duration":"546.701667ms","start":"2026-02-06T00:46:24.593495Z","end":"2026-02-06T00:46:25.140197Z","steps":["trace[1957514216] 'range keys from in-memory index tree'  (duration: 546.551893ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:25.140265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:24.59346Z","time spent":"546.79403ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-06T00:46:25.140579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.675842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-06T00:46:25.140635Z","caller":"traceutil/trace.go:171","msg":"trace[1467092279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:545; }","duration":"528.739374ms","start":"2026-02-06T00:46:24.611864Z","end":"2026-02-06T00:46:25.140603Z","steps":["trace[1467092279] 'range keys from in-memory index tree'  (duration: 528.531849ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:25.140669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:24.611848Z","time spent":"528.813005ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-06T00:46:25.140932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.34255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-06T00:46:25.140996Z","caller":"traceutil/trace.go:171","msg":"trace[1994900153] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:545; }","duration":"518.421812ms","start":"2026-02-06T00:46:24.622562Z","end":"2026-02-06T00:46:25.140984Z","steps":["trace[1994900153] 'range keys from in-memory index tree'  (duration: 518.240538ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:25.141028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:24.622555Z","time spent":"518.465303ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-06T00:46:25.141284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.274082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-06T00:46:25.141326Z","caller":"traceutil/trace.go:171","msg":"trace[71584164] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:545; }","duration":"511.326854ms","start":"2026-02-06T00:46:24.629986Z","end":"2026-02-06T00:46:25.141313Z","steps":["trace[71584164] 'range keys from in-memory index tree'  (duration: 511.18919ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:25.141379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:24.62998Z","time spent":"511.374594ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-06T00:46:25.172118Z","caller":"traceutil/trace.go:171","msg":"trace[874052851] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"469.397272ms","start":"2026-02-06T00:46:24.7027Z","end":"2026-02-06T00:46:25.172098Z","steps":["trace[874052851] 'process raft request'  (duration: 469.269009ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:25.172407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:24.702673Z","time spent":"469.661397ms","remote":"127.0.0.1:54470","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:512 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-06T00:46:25.17229Z","caller":"traceutil/trace.go:171","msg":"trace[566531808] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:565; }","duration":"205.367002ms","start":"2026-02-06T00:46:24.966907Z","end":"2026-02-06T00:46:25.172274Z","steps":["trace[566531808] 'read index received'  (duration: 205.334091ms)","trace[566531808] 'applied index is now lower than readState.Index'  (duration: 5.73µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:46:25.173044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.112088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-06T00:46:25.173239Z","caller":"traceutil/trace.go:171","msg":"trace[778568164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:546; }","duration":"206.314893ms","start":"2026-02-06T00:46:24.966859Z","end":"2026-02-06T00:46:25.173174Z","steps":["trace[778568164] 'agreement among raft nodes before linearized reading'  (duration: 205.975195ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:46:27.725117Z","caller":"traceutil/trace.go:171","msg":"trace[2087074159] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"128.445904ms","start":"2026-02-06T00:46:27.596652Z","end":"2026-02-06T00:46:27.725098Z","steps":["trace[2087074159] 'read index received'  (duration: 54.851352ms)","trace[2087074159] 'applied index is now lower than readState.Index'  (duration: 73.593832ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:46:27.72532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.646889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"}
{"level":"info","ts":"2026-02-06T00:46:27.725346Z","caller":"traceutil/trace.go:171","msg":"trace[1747752461] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:596; }","duration":"128.711421ms","start":"2026-02-06T00:46:27.596625Z","end":"2026-02-06T00:46:27.725336Z","steps":["trace[1747752461] 'agreement among raft nodes before linearized reading'  (duration: 128.574568ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:46:27.725344Z","caller":"traceutil/trace.go:171","msg":"trace[838668985] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"143.882631ms","start":"2026-02-06T00:46:27.58143Z","end":"2026-02-06T00:46:27.725313Z","steps":["trace[838668985] 'process raft request'  (duration: 70.135885ms)","trace[838668985] 'compare'  (duration: 73.431459ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:46:33.415123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.815095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-06T00:46:33.415597Z","caller":"traceutil/trace.go:171","msg":"trace[418778021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"110.41901ms","start":"2026-02-06T00:46:33.305168Z","end":"2026-02-06T00:46:33.415587Z","steps":["trace[418778021] 'range keys from in-memory index tree'  (duration: 109.753155ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:33.415351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.832527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-06T00:46:33.415897Z","caller":"traceutil/trace.go:171","msg":"trace[761579873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"110.40534ms","start":"2026-02-06T00:46:33.305487Z","end":"2026-02-06T00:46:33.415892Z","steps":["trace[761579873] 'range keys from in-memory index tree'  (duration: 109.773595ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:34.903229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.732343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dvg7x\" ","response":"range_response_count:1 size:18246"}
{"level":"info","ts":"2026-02-06T00:46:34.903283Z","caller":"traceutil/trace.go:171","msg":"trace[1404189095] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dvg7x; range_end:; response_count:1; response_revision:639; }","duration":"462.814144ms","start":"2026-02-06T00:46:34.440456Z","end":"2026-02-06T00:46:34.90327Z","steps":["trace[1404189095] 'range keys from in-memory index tree'  (duration: 462.61305ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:34.903309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:34.440444Z","time spent":"462.859856ms","remote":"127.0.0.1:54398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18269,"request content":"key:\"/registry/pods/kube-system/cilium-dvg7x\" "}
{"level":"warn","ts":"2026-02-06T00:46:35.514141Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148899994904679,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-06T00:46:36.014871Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148899994904679,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-06T00:46:36.426599Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.510672936s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-06T00:46:36.427059Z","caller":"traceutil/trace.go:171","msg":"trace[1123598171] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"1.511202147s","start":"2026-02-06T00:46:34.915834Z","end":"2026-02-06T00:46:36.427037Z","steps":["trace[1123598171] 'process raft request'  (duration: 1.511064913s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:36.427188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:34.915818Z","time spent":"1.51130949s","remote":"127.0.0.1:54398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18231,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-dvg7x\" mod_revision:619 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-dvg7x\" value_size:18182 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-dvg7x\" > >"}
{"level":"warn","ts":"2026-02-06T00:46:37.013751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000344602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-06T00:46:37.013816Z","caller":"traceutil/trace.go:171","msg":"trace[704824741] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000444294s","start":"2026-02-06T00:46:35.013357Z","end":"2026-02-06T00:46:37.013802Z","steps":["trace[704824741] 'agreement among raft nodes before linearized reading'  (duration: 2.000360092s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.013854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:35.013343Z","time spent":"2.000500445s","remote":"127.0.0.1:54204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-06T00:46:37.110274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.000001ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994904681 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:546 > 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-02-06T00:46:37.110366Z","caller":"traceutil/trace.go:171","msg":"trace[576949677] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:662; }","duration":"2.096962001s","start":"2026-02-06T00:46:35.013384Z","end":"2026-02-06T00:46:37.110346Z","steps":["trace[576949677] 'read index received'  (duration: 1.414428734s)","trace[576949677] 'applied index is now lower than readState.Index'  (duration: 682.532277ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:46:37.110517Z","caller":"traceutil/trace.go:171","msg":"trace[111427242] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"1.700674213s","start":"2026-02-06T00:46:35.409832Z","end":"2026-02-06T00:46:37.110506Z","steps":["trace[111427242] 'process raft request'  (duration: 1.203385665s)","trace[111427242] 'compare'  (duration: 496.585002ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:46:37.110563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:35.409814Z","time spent":"1.700726965s","remote":"127.0.0.1:54470","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:546 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-06T00:46:37.110744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.843598214s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-06T00:46:37.110764Z","caller":"traceutil/trace.go:171","msg":"trace[1669094441] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"1.843637314s","start":"2026-02-06T00:46:35.267121Z","end":"2026-02-06T00:46:37.110758Z","steps":["trace[1669094441] 'agreement among raft nodes before linearized reading'  (duration: 1.843561232s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.110783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:35.267106Z","time spent":"1.843673024s","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-06T00:46:37.111007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.709487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dvg7x\" ","response":"range_response_count:1 size:18246"}
{"level":"info","ts":"2026-02-06T00:46:37.111025Z","caller":"traceutil/trace.go:171","msg":"trace[48031425] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dvg7x; range_end:; response_count:1; response_revision:641; }","duration":"672.756198ms","start":"2026-02-06T00:46:36.438263Z","end":"2026-02-06T00:46:37.11102Z","steps":["trace[48031425] 'agreement among raft nodes before linearized reading'  (duration: 672.700287ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.111046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:36.438249Z","time spent":"672.793029ms","remote":"127.0.0.1:54398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18269,"request content":"key:\"/registry/pods/kube-system/cilium-dvg7x\" "}
{"level":"warn","ts":"2026-02-06T00:46:37.111161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.621615678s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-06T00:46:37.111177Z","caller":"traceutil/trace.go:171","msg":"trace[1943843484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:641; }","duration":"1.621637408s","start":"2026-02-06T00:46:35.489535Z","end":"2026-02-06T00:46:37.111173Z","steps":["trace[1943843484] 'agreement among raft nodes before linearized reading'  (duration: 1.621583387s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.111193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:35.489533Z","time spent":"1.621656139s","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-06T00:46:37.111291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.621762041s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-06T00:46:37.111306Z","caller":"traceutil/trace.go:171","msg":"trace[1561004043] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:641; }","duration":"1.621794251s","start":"2026-02-06T00:46:35.489508Z","end":"2026-02-06T00:46:37.111302Z","steps":["trace[1561004043] 'agreement among raft nodes before linearized reading'  (duration: 1.62175026s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.111321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:35.489495Z","time spent":"1.621822762s","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-06T00:46:37.111447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.678642587s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-06T00:46:37.111463Z","caller":"traceutil/trace.go:171","msg":"trace[50222524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:641; }","duration":"1.678658427s","start":"2026-02-06T00:46:35.4328Z","end":"2026-02-06T00:46:37.111458Z","steps":["trace[50222524] 'agreement among raft nodes before linearized reading'  (duration: 1.678608486s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.111478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:35.432778Z","time spent":"1.678696079s","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-06T00:46:37.111577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.685621715s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-06T00:46:37.111593Z","caller":"traceutil/trace.go:171","msg":"trace[1306809359] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:641; }","duration":"1.685656435s","start":"2026-02-06T00:46:35.425932Z","end":"2026-02-06T00:46:37.111589Z","steps":["trace[1306809359] 'agreement among raft nodes before linearized reading'  (duration: 1.685609634s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.111609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:35.425921Z","time spent":"1.685683957s","remote":"127.0.0.1:54222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.19\" "}
{"level":"warn","ts":"2026-02-06T00:46:37.111715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.83635476s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-06T00:46:37.111731Z","caller":"traceutil/trace.go:171","msg":"trace[1142587329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:641; }","duration":"1.83638154s","start":"2026-02-06T00:46:35.275345Z","end":"2026-02-06T00:46:37.111727Z","steps":["trace[1142587329] 'agreement among raft nodes before linearized reading'  (duration: 1.836332969s)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.111747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:35.275339Z","time spent":"1.836404582s","remote":"127.0.0.1:54470","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-02-06T00:46:37.515827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:37.127661Z","time spent":"388.162066ms","remote":"127.0.0.1:54222","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-06T00:46:37.58073Z","caller":"traceutil/trace.go:171","msg":"trace[1272026839] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:663; }","duration":"446.459896ms","start":"2026-02-06T00:46:37.13425Z","end":"2026-02-06T00:46:37.58071Z","steps":["trace[1272026839] 'read index received'  (duration: 309.933061ms)","trace[1272026839] 'applied index is now lower than readState.Index'  (duration: 136.525935ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:46:37.580891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.6229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:46:37.580921Z","caller":"traceutil/trace.go:171","msg":"trace[1706633840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"446.6785ms","start":"2026-02-06T00:46:37.134233Z","end":"2026-02-06T00:46:37.580911Z","steps":["trace[1706633840] 'agreement among raft nodes before linearized reading'  (duration: 446.552818ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.580951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:37.134227Z","time spent":"446.717661ms","remote":"127.0.0.1:54204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-06T00:46:37.581255Z","caller":"traceutil/trace.go:171","msg":"trace[1710004327] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"449.491855ms","start":"2026-02-06T00:46:37.131751Z","end":"2026-02-06T00:46:37.581243Z","steps":["trace[1710004327] 'process raft request'  (duration: 448.541873ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.581333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:37.131741Z","time spent":"449.542016ms","remote":"127.0.0.1:54470","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:635 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-06T00:46:37.58147Z","caller":"traceutil/trace.go:171","msg":"trace[722446380] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"445.036655ms","start":"2026-02-06T00:46:37.136423Z","end":"2026-02-06T00:46:37.58146Z","steps":["trace[722446380] 'process raft request'  (duration: 444.184995ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.581531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:37.136417Z","time spent":"445.081175ms","remote":"127.0.0.1:54470","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:637 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:46:37.581605Z","caller":"traceutil/trace.go:171","msg":"trace[998776931] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"445.097425ms","start":"2026-02-06T00:46:37.136495Z","end":"2026-02-06T00:46:37.581593Z","steps":["trace[998776931] 'process raft request'  (duration: 444.156784ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:46:37.581642Z","caller":"traceutil/trace.go:171","msg":"trace[1662491722] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"449.842002ms","start":"2026-02-06T00:46:37.131792Z","end":"2026-02-06T00:46:37.581634Z","steps":["trace[1662491722] 'process raft request'  (duration: 448.654405ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.581667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:37.136491Z","time spent":"445.144457ms","remote":"127.0.0.1:54398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18043,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-dvg7x\" mod_revision:640 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-dvg7x\" value_size:17994 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-dvg7x\" > >"}
{"level":"warn","ts":"2026-02-06T00:46:37.581676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:37.131788Z","time spent":"449.870053ms","remote":"127.0.0.1:54268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189181c19eae5372\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189181c19eae5372\" value_size:672 lease:988148899994903484 >> failure:<>"}
{"level":"info","ts":"2026-02-06T00:46:37.581763Z","caller":"traceutil/trace.go:171","msg":"trace[1261290287] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"449.932714ms","start":"2026-02-06T00:46:37.131825Z","end":"2026-02-06T00:46:37.581758Z","steps":["trace[1261290287] 'process raft request'  (duration: 448.659055ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.581792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:37.131821Z","time spent":"449.955476ms","remote":"127.0.0.1:54470","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:639 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:46:37.581834Z","caller":"traceutil/trace.go:171","msg":"trace[1519552608] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"447.291296ms","start":"2026-02-06T00:46:37.134538Z","end":"2026-02-06T00:46:37.58183Z","steps":["trace[1519552608] 'process raft request'  (duration: 445.996046ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.58186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:37.134532Z","time spent":"447.313116ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:636 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-06T00:46:37.581968Z","caller":"traceutil/trace.go:171","msg":"trace[1120822086] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"447.392528ms","start":"2026-02-06T00:46:37.13457Z","end":"2026-02-06T00:46:37.581962Z","steps":["trace[1120822086] 'process raft request'  (duration: 445.993016ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:37.581997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:46:37.134566Z","time spent":"447.415598ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:638 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:46:39.866678Z","caller":"traceutil/trace.go:171","msg":"trace[1061177791] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"214.308182ms","start":"2026-02-06T00:46:39.652351Z","end":"2026-02-06T00:46:39.866659Z","steps":["trace[1061177791] 'process raft request'  (duration: 214.255611ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:46:39.866927Z","caller":"traceutil/trace.go:171","msg":"trace[1647990826] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"214.715252ms","start":"2026-02-06T00:46:39.652203Z","end":"2026-02-06T00:46:39.866918Z","steps":["trace[1647990826] 'process raft request'  (duration: 207.156432ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:46:39.875125Z","caller":"traceutil/trace.go:171","msg":"trace[1163936906] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"178.918418ms","start":"2026-02-06T00:46:39.696192Z","end":"2026-02-06T00:46:39.875111Z","steps":["trace[1163936906] 'process raft request'  (duration: 178.813515ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:46:47.826831Z","caller":"traceutil/trace.go:171","msg":"trace[1976865668] linearizableReadLoop","detail":"{readStateIndex:755; appliedIndex:754; }","duration":"156.805401ms","start":"2026-02-06T00:46:47.670008Z","end":"2026-02-06T00:46:47.826814Z","steps":["trace[1976865668] 'read index received'  (duration: 156.652198ms)","trace[1976865668] 'applied index is now lower than readState.Index'  (duration: 152.573µs)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:46:47.827506Z","caller":"traceutil/trace.go:171","msg":"trace[865564732] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"157.867965ms","start":"2026-02-06T00:46:47.669628Z","end":"2026-02-06T00:46:47.827496Z","steps":["trace[865564732] 'process raft request'  (duration: 157.077758ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:47.827885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.619248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-06T00:46:47.827911Z","caller":"traceutil/trace.go:171","msg":"trace[1140097191] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:730; }","duration":"156.668078ms","start":"2026-02-06T00:46:47.671235Z","end":"2026-02-06T00:46:47.827903Z","steps":["trace[1140097191] 'agreement among raft nodes before linearized reading'  (duration: 156.597407ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:47.828062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.700881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-06T00:46:47.828081Z","caller":"traceutil/trace.go:171","msg":"trace[2016929733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:730; }","duration":"158.08428ms","start":"2026-02-06T00:46:47.669991Z","end":"2026-02-06T00:46:47.828075Z","steps":["trace[2016929733] 'agreement among raft nodes before linearized reading'  (duration: 157.647401ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:47.828023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.73054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-06T00:46:47.828808Z","caller":"traceutil/trace.go:171","msg":"trace[311947048] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:730; }","duration":"157.525788ms","start":"2026-02-06T00:46:47.671267Z","end":"2026-02-06T00:46:47.828793Z","steps":["trace[311947048] 'agreement among raft nodes before linearized reading'  (duration: 156.721039ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:46:47.944884Z","caller":"traceutil/trace.go:171","msg":"trace[1205506691] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"109.724684ms","start":"2026-02-06T00:46:47.835143Z","end":"2026-02-06T00:46:47.944868Z","steps":["trace[1205506691] 'process raft request'  (duration: 109.672433ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:46:47.945093Z","caller":"traceutil/trace.go:171","msg":"trace[649943569] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"113.759185ms","start":"2026-02-06T00:46:47.831325Z","end":"2026-02-06T00:46:47.945084Z","steps":["trace[649943569] 'process raft request'  (duration: 18.467145ms)","trace[649943569] 'compare'  (duration: 94.862661ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:46:47.945202Z","caller":"traceutil/trace.go:171","msg":"trace[2093085265] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"111.77038ms","start":"2026-02-06T00:46:47.833424Z","end":"2026-02-06T00:46:47.945195Z","steps":["trace[2093085265] 'process raft request'  (duration: 111.356541ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:46:48.242746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.345077ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994904844 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:3660-second id:0db69c306963a90b>","response":"size:41"}
{"level":"info","ts":"2026-02-06T00:47:01.177737Z","caller":"traceutil/trace.go:171","msg":"trace[2121210857] linearizableReadLoop","detail":"{readStateIndex:803; appliedIndex:802; }","duration":"362.840961ms","start":"2026-02-06T00:47:00.814854Z","end":"2026-02-06T00:47:01.177695Z","steps":["trace[2121210857] 'read index received'  (duration: 289.771396ms)","trace[2121210857] 'applied index is now lower than readState.Index'  (duration: 73.067695ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:47:01.17793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.054886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-06T00:47:01.177969Z","caller":"traceutil/trace.go:171","msg":"trace[118827639] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:774; }","duration":"363.144328ms","start":"2026-02-06T00:47:00.814813Z","end":"2026-02-06T00:47:01.177958Z","steps":["trace[118827639] 'agreement among raft nodes before linearized reading'  (duration: 363.031185ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:01.178003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:00.81479Z","time spent":"363.203499ms","remote":"127.0.0.1:54550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":51,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-02-06T00:47:01.178187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.476254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:47:01.178213Z","caller":"traceutil/trace.go:171","msg":"trace[34648774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:774; }","duration":"164.527444ms","start":"2026-02-06T00:47:01.013677Z","end":"2026-02-06T00:47:01.178205Z","steps":["trace[34648774] 'agreement among raft nodes before linearized reading'  (duration: 164.489193ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:01.819259Z","caller":"traceutil/trace.go:171","msg":"trace[1810127219] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"106.981679ms","start":"2026-02-06T00:47:01.71225Z","end":"2026-02-06T00:47:01.819232Z","steps":["trace[1810127219] 'process raft request'  (duration: 106.797365ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:02.321936Z","caller":"traceutil/trace.go:171","msg":"trace[1152385398] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"234.593104ms","start":"2026-02-06T00:47:02.08732Z","end":"2026-02-06T00:47:02.321913Z","steps":["trace[1152385398] 'process raft request'  (duration: 234.458971ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:03.070533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.892852ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994904976 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:772 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:47:03.071007Z","caller":"traceutil/trace.go:171","msg":"trace[946031474] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"983.165296ms","start":"2026-02-06T00:47:02.087797Z","end":"2026-02-06T00:47:03.070963Z","steps":["trace[946031474] 'process raft request'  (duration: 557.763452ms)","trace[946031474] 'compare'  (duration: 424.291349ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:47:03.071074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:02.087776Z","time spent":"983.264459ms","remote":"127.0.0.1:54470","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:772 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:47:03.071208Z","caller":"traceutil/trace.go:171","msg":"trace[1230604360] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"983.254379ms","start":"2026-02-06T00:47:02.087945Z","end":"2026-02-06T00:47:03.071199Z","steps":["trace[1230604360] 'process raft request'  (duration: 982.673385ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:03.071255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:02.087916Z","time spent":"983.31434ms","remote":"127.0.0.1:54470","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:773 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:47:19.427454Z","caller":"traceutil/trace.go:171","msg":"trace[901730915] linearizableReadLoop","detail":"{readStateIndex:911; appliedIndex:910; }","duration":"144.047643ms","start":"2026-02-06T00:47:19.283385Z","end":"2026-02-06T00:47:19.427433Z","steps":["trace[901730915] 'read index received'  (duration: 143.86646ms)","trace[901730915] 'applied index is now lower than readState.Index'  (duration: 180.293µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:47:19.427615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.215757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-06T00:47:19.427637Z","caller":"traceutil/trace.go:171","msg":"trace[408285110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:878; }","duration":"144.276079ms","start":"2026-02-06T00:47:19.283353Z","end":"2026-02-06T00:47:19.427629Z","steps":["trace[408285110] 'agreement among raft nodes before linearized reading'  (duration: 144.156006ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:19.427868Z","caller":"traceutil/trace.go:171","msg":"trace[220369126] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"225.656617ms","start":"2026-02-06T00:47:19.202204Z","end":"2026-02-06T00:47:19.42786Z","steps":["trace[220369126] 'process raft request'  (duration: 225.107925ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:20.696661Z","caller":"traceutil/trace.go:171","msg":"trace[1274453593] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"263.679082ms","start":"2026-02-06T00:47:20.432965Z","end":"2026-02-06T00:47:20.696644Z","steps":["trace[1274453593] 'process raft request'  (duration: 263.58287ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:21.036276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.78531ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994905215 > lease_revoke:<id:0db69c306963a9a2>","response":"size:28"}
{"level":"warn","ts":"2026-02-06T00:47:21.83178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.453215ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994905221 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:879 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:47:21.831889Z","caller":"traceutil/trace.go:171","msg":"trace[258670995] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"309.935419ms","start":"2026-02-06T00:47:21.521933Z","end":"2026-02-06T00:47:21.831868Z","steps":["trace[258670995] 'process raft request'  (duration: 108.31536ms)","trace[258670995] 'compare'  (duration: 201.25165ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:47:21.831948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:21.521917Z","time spent":"310.00379ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:879 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-06T00:47:22.177585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.265368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-06T00:47:22.177656Z","caller":"traceutil/trace.go:171","msg":"trace[105634303] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:886; }","duration":"220.362051ms","start":"2026-02-06T00:47:21.957276Z","end":"2026-02-06T00:47:22.177638Z","steps":["trace[105634303] 'count revisions from in-memory index tree'  (duration: 220.146626ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:22.177843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.532711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:47:22.177869Z","caller":"traceutil/trace.go:171","msg":"trace[1603925828] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:886; }","duration":"162.595631ms","start":"2026-02-06T00:47:22.015265Z","end":"2026-02-06T00:47:22.177861Z","steps":["trace[1603925828] 'range keys from in-memory index tree'  (duration: 162.463219ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:22.178082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.541397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-06T00:47:22.178143Z","caller":"traceutil/trace.go:171","msg":"trace[2132176734] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:886; }","duration":"135.594068ms","start":"2026-02-06T00:47:22.042506Z","end":"2026-02-06T00:47:22.1781Z","steps":["trace[2132176734] 'range keys from in-memory index tree'  (duration: 135.403524ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:22.307777Z","caller":"traceutil/trace.go:171","msg":"trace[1098679607] linearizableReadLoop","detail":"{readStateIndex:921; appliedIndex:920; }","duration":"100.544447ms","start":"2026-02-06T00:47:22.207211Z","end":"2026-02-06T00:47:22.307756Z","steps":["trace[1098679607] 'read index received'  (duration: 100.390974ms)","trace[1098679607] 'applied index is now lower than readState.Index'  (duration: 152.353µs)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:22.308051Z","caller":"traceutil/trace.go:171","msg":"trace[1929824479] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"123.80386ms","start":"2026-02-06T00:47:22.184227Z","end":"2026-02-06T00:47:22.308031Z","steps":["trace[1929824479] 'process raft request'  (duration: 123.39287ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:22.308162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.937168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-06T00:47:22.309224Z","caller":"traceutil/trace.go:171","msg":"trace[258389385] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:887; }","duration":"102.038991ms","start":"2026-02-06T00:47:22.207176Z","end":"2026-02-06T00:47:22.309215Z","steps":["trace[258389385] 'agreement among raft nodes before linearized reading'  (duration: 100.910117ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:22.792557Z","caller":"traceutil/trace.go:171","msg":"trace[46305451] linearizableReadLoop","detail":"{readStateIndex:923; appliedIndex:922; }","duration":"175.130967ms","start":"2026-02-06T00:47:22.617406Z","end":"2026-02-06T00:47:22.792537Z","steps":["trace[46305451] 'read index received'  (duration: 174.904531ms)","trace[46305451] 'applied index is now lower than readState.Index'  (duration: 225.616µs)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:22.792666Z","caller":"traceutil/trace.go:171","msg":"trace[264713818] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"454.438593ms","start":"2026-02-06T00:47:22.338205Z","end":"2026-02-06T00:47:22.792644Z","steps":["trace[264713818] 'process raft request'  (duration: 454.215478ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:22.792776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:22.338185Z","time spent":"454.522125ms","remote":"127.0.0.1:54268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":756,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-z8wxc.189181cc255b404d\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-z8wxc.189181cc255b404d\" value_size:663 lease:988148899994904843 >> failure:<>"}
{"level":"warn","ts":"2026-02-06T00:47:22.793199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.778821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-06T00:47:22.793245Z","caller":"traceutil/trace.go:171","msg":"trace[27682199] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:889; }","duration":"175.872533ms","start":"2026-02-06T00:47:22.617361Z","end":"2026-02-06T00:47:22.793234Z","steps":["trace[27682199] 'agreement among raft nodes before linearized reading'  (duration: 175.72383ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:23.027915Z","caller":"traceutil/trace.go:171","msg":"trace[423128793] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"181.1701ms","start":"2026-02-06T00:47:22.846727Z","end":"2026-02-06T00:47:23.027897Z","steps":["trace[423128793] 'process raft request'  (duration: 124.890453ms)","trace[423128793] 'compare'  (duration: 56.033041ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:47:25.805956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.244699ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994905258 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:893 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:47:25.806022Z","caller":"traceutil/trace.go:171","msg":"trace[1702858002] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"257.446545ms","start":"2026-02-06T00:47:25.548562Z","end":"2026-02-06T00:47:25.806008Z","steps":["trace[1702858002] 'process raft request'  (duration: 118.094965ms)","trace[1702858002] 'compare'  (duration: 139.024343ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:26.478804Z","caller":"traceutil/trace.go:171","msg":"trace[527939184] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"126.766074ms","start":"2026-02-06T00:47:26.352018Z","end":"2026-02-06T00:47:26.478784Z","steps":["trace[527939184] 'process raft request'  (duration: 126.267443ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:27.242555Z","caller":"traceutil/trace.go:171","msg":"trace[1077644207] linearizableReadLoop","detail":"{readStateIndex:938; appliedIndex:937; }","duration":"225.779469ms","start":"2026-02-06T00:47:27.016757Z","end":"2026-02-06T00:47:27.242537Z","steps":["trace[1077644207] 'read index received'  (duration: 225.633136ms)","trace[1077644207] 'applied index is now lower than readState.Index'  (duration: 145.693µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:47:27.242654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.879661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:47:27.242675Z","caller":"traceutil/trace.go:171","msg":"trace[25913169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:903; }","duration":"225.951223ms","start":"2026-02-06T00:47:27.016717Z","end":"2026-02-06T00:47:27.242668Z","steps":["trace[25913169] 'agreement among raft nodes before linearized reading'  (duration: 225.884982ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:27.24292Z","caller":"traceutil/trace.go:171","msg":"trace[269061751] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"360.048517ms","start":"2026-02-06T00:47:26.882864Z","end":"2026-02-06T00:47:27.242913Z","steps":["trace[269061751] 'process raft request'  (duration: 359.572127ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:27.242975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:26.882839Z","time spent":"360.097799ms","remote":"127.0.0.1:54470","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:897 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:47:30.153273Z","caller":"traceutil/trace.go:171","msg":"trace[1538881020] linearizableReadLoop","detail":"{readStateIndex:947; appliedIndex:946; }","duration":"106.190383ms","start":"2026-02-06T00:47:30.047062Z","end":"2026-02-06T00:47:30.153253Z","steps":["trace[1538881020] 'read index received'  (duration: 105.973928ms)","trace[1538881020] 'applied index is now lower than readState.Index'  (duration: 215.615µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:47:30.153493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.408588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-06T00:47:30.153533Z","caller":"traceutil/trace.go:171","msg":"trace[213949097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:912; }","duration":"106.463439ms","start":"2026-02-06T00:47:30.047058Z","end":"2026-02-06T00:47:30.153521Z","steps":["trace[213949097] 'agreement among raft nodes before linearized reading'  (duration: 106.277715ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:30.153805Z","caller":"traceutil/trace.go:171","msg":"trace[326049437] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"281.062664ms","start":"2026-02-06T00:47:29.872732Z","end":"2026-02-06T00:47:30.153795Z","steps":["trace[326049437] 'process raft request'  (duration: 280.359849ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:30.616809Z","caller":"traceutil/trace.go:171","msg":"trace[1269684192] linearizableReadLoop","detail":"{readStateIndex:951; appliedIndex:950; }","duration":"101.344807ms","start":"2026-02-06T00:47:30.515447Z","end":"2026-02-06T00:47:30.616792Z","steps":["trace[1269684192] 'read index received'  (duration: 10.792697ms)","trace[1269684192] 'applied index is now lower than readState.Index'  (duration: 90.55115ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:30.616901Z","caller":"traceutil/trace.go:171","msg":"trace[1185278610] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"201.141979ms","start":"2026-02-06T00:47:30.415753Z","end":"2026-02-06T00:47:30.616895Z","steps":["trace[1185278610] 'process raft request'  (duration: 110.541387ms)","trace[1185278610] 'compare'  (duration: 90.405097ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:47:30.61711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.656774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-06T00:47:30.617152Z","caller":"traceutil/trace.go:171","msg":"trace[594441678] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:916; }","duration":"101.709285ms","start":"2026-02-06T00:47:30.515436Z","end":"2026-02-06T00:47:30.617145Z","steps":["trace[594441678] 'agreement among raft nodes before linearized reading'  (duration: 101.581702ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:30.740046Z","caller":"traceutil/trace.go:171","msg":"trace[1532948165] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"118.495713ms","start":"2026-02-06T00:47:30.621531Z","end":"2026-02-06T00:47:30.740027Z","steps":["trace[1532948165] 'process raft request'  (duration: 102.691576ms)","trace[1532948165] 'compare'  (duration: 15.730696ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:33.212323Z","caller":"traceutil/trace.go:171","msg":"trace[432999606] linearizableReadLoop","detail":"{readStateIndex:958; appliedIndex:957; }","duration":"467.733945ms","start":"2026-02-06T00:47:32.744562Z","end":"2026-02-06T00:47:33.212296Z","steps":["trace[432999606] 'read index received'  (duration: 467.582982ms)","trace[432999606] 'applied index is now lower than readState.Index'  (duration: 150.313µs)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:33.212457Z","caller":"traceutil/trace.go:171","msg":"trace[1966501560] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"529.387749ms","start":"2026-02-06T00:47:32.683061Z","end":"2026-02-06T00:47:33.212449Z","steps":["trace[1966501560] 'process raft request'  (duration: 529.130544ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:33.212481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.90637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-06T00:47:33.212503Z","caller":"traceutil/trace.go:171","msg":"trace[1430975484] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:922; }","duration":"467.96754ms","start":"2026-02-06T00:47:32.744529Z","end":"2026-02-06T00:47:33.212497Z","steps":["trace[1430975484] 'agreement among raft nodes before linearized reading'  (duration: 467.847248ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:33.212518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:32.68305Z","time spent":"529.426951ms","remote":"127.0.0.1:54470","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:917 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-06T00:47:33.212534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:32.744513Z","time spent":"468.004812ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-06T00:47:33.41052Z","caller":"traceutil/trace.go:171","msg":"trace[1021959198] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"194.567344ms","start":"2026-02-06T00:47:33.215936Z","end":"2026-02-06T00:47:33.410504Z","steps":["trace[1021959198] 'process raft request'  (duration: 107.812249ms)","trace[1021959198] 'compare'  (duration: 86.561671ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:47:33.685672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.113954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:47:33.685717Z","caller":"traceutil/trace.go:171","msg":"trace[351606198] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:924; }","duration":"123.200926ms","start":"2026-02-06T00:47:33.562505Z","end":"2026-02-06T00:47:33.685706Z","steps":["trace[351606198] 'count revisions from in-memory index tree'  (duration: 123.052193ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:35.741276Z","caller":"traceutil/trace.go:171","msg":"trace[903744350] linearizableReadLoop","detail":"{readStateIndex:964; appliedIndex:963; }","duration":"312.940705ms","start":"2026-02-06T00:47:35.428318Z","end":"2026-02-06T00:47:35.741259Z","steps":["trace[903744350] 'read index received'  (duration: 312.7142ms)","trace[903744350] 'applied index is now lower than readState.Index'  (duration: 225.775µs)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:35.741367Z","caller":"traceutil/trace.go:171","msg":"trace[1787405800] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"324.998709ms","start":"2026-02-06T00:47:35.416362Z","end":"2026-02-06T00:47:35.74136Z","steps":["trace[1787405800] 'process raft request'  (duration: 324.696012ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:35.741438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:35.416345Z","time spent":"325.038309ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:923 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-06T00:47:35.741556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.251251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-06T00:47:35.741596Z","caller":"traceutil/trace.go:171","msg":"trace[1224803665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:928; }","duration":"257.299122ms","start":"2026-02-06T00:47:35.484286Z","end":"2026-02-06T00:47:35.741586Z","steps":["trace[1224803665] 'agreement among raft nodes before linearized reading'  (duration: 257.190759ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:35.741681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.362784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-06T00:47:35.741692Z","caller":"traceutil/trace.go:171","msg":"trace[548073453] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:928; }","duration":"313.385694ms","start":"2026-02-06T00:47:35.428303Z","end":"2026-02-06T00:47:35.741689Z","steps":["trace[548073453] 'agreement among raft nodes before linearized reading'  (duration: 313.350263ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:35.741705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:35.428296Z","time spent":"313.404674ms","remote":"127.0.0.1:54222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.19\" "}
{"level":"info","ts":"2026-02-06T00:47:37.825013Z","caller":"traceutil/trace.go:171","msg":"trace[601883590] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"550.579235ms","start":"2026-02-06T00:47:37.274402Z","end":"2026-02-06T00:47:37.824981Z","steps":["trace[601883590] 'process raft request'  (duration: 550.323989ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:37.825125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:37.274393Z","time spent":"550.674377ms","remote":"127.0.0.1:54470","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:927 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-06T00:47:38.046185Z","caller":"traceutil/trace.go:171","msg":"trace[1351231284] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"215.457713ms","start":"2026-02-06T00:47:37.830714Z","end":"2026-02-06T00:47:38.046171Z","steps":["trace[1351231284] 'process raft request'  (duration: 153.560342ms)","trace[1351231284] 'compare'  (duration: 61.601443ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:38.046266Z","caller":"traceutil/trace.go:171","msg":"trace[808478738] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"215.448872ms","start":"2026-02-06T00:47:37.830812Z","end":"2026-02-06T00:47:38.046261Z","steps":["trace[808478738] 'process raft request'  (duration: 215.172016ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:38.598587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.050055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-06T00:47:38.598656Z","caller":"traceutil/trace.go:171","msg":"trace[2059678990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:936; }","duration":"332.142536ms","start":"2026-02-06T00:47:38.266498Z","end":"2026-02-06T00:47:38.59864Z","steps":["trace[2059678990] 'range keys from in-memory index tree'  (duration: 331.866921ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:38.598704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:38.266429Z","time spent":"332.26698ms","remote":"127.0.0.1:54470","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-02-06T00:47:38.610741Z","caller":"traceutil/trace.go:171","msg":"trace[912763036] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"285.566193ms","start":"2026-02-06T00:47:38.325163Z","end":"2026-02-06T00:47:38.610729Z","steps":["trace[912763036] 'process raft request'  (duration: 285.499951ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:40.015393Z","caller":"traceutil/trace.go:171","msg":"trace[267812806] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"185.032985ms","start":"2026-02-06T00:47:39.830345Z","end":"2026-02-06T00:47:40.015378Z","steps":["trace[267812806] 'process raft request'  (duration: 184.939913ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:40.174492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.564737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-06T00:47:40.174546Z","caller":"traceutil/trace.go:171","msg":"trace[1891647970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:939; }","duration":"125.652921ms","start":"2026-02-06T00:47:40.048882Z","end":"2026-02-06T00:47:40.174535Z","steps":["trace[1891647970] 'range keys from in-memory index tree'  (duration: 125.456495ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:40.174641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.67041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-06T00:47:40.174679Z","caller":"traceutil/trace.go:171","msg":"trace[1814143084] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:939; }","duration":"125.739431ms","start":"2026-02-06T00:47:40.04893Z","end":"2026-02-06T00:47:40.174669Z","steps":["trace[1814143084] 'range keys from in-memory index tree'  (duration: 125.594218ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:40.688338Z","caller":"traceutil/trace.go:171","msg":"trace[1262628561] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"510.922903ms","start":"2026-02-06T00:47:40.177283Z","end":"2026-02-06T00:47:40.688206Z","steps":["trace[1262628561] 'process raft request'  (duration: 510.810131ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:40.688428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:40.177269Z","time spent":"511.109787ms","remote":"127.0.0.1:54470","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:934 > 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-02-06T00:47:40.718628Z","caller":"traceutil/trace.go:171","msg":"trace[229313355] linearizableReadLoop","detail":"{readStateIndex:980; appliedIndex:976; }","duration":"100.361084ms","start":"2026-02-06T00:47:40.618252Z","end":"2026-02-06T00:47:40.718613Z","steps":["trace[229313355] 'read index received'  (duration: 69.736972ms)","trace[229313355] 'applied index is now lower than readState.Index'  (duration: 30.623472ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:47:40.718783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.515498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-06T00:47:40.718809Z","caller":"traceutil/trace.go:171","msg":"trace[57362020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:943; }","duration":"100.570769ms","start":"2026-02-06T00:47:40.618227Z","end":"2026-02-06T00:47:40.718798Z","steps":["trace[57362020] 'agreement among raft nodes before linearized reading'  (duration: 100.451187ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:40.719017Z","caller":"traceutil/trace.go:171","msg":"trace[1707776961] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"541.188638ms","start":"2026-02-06T00:47:40.177821Z","end":"2026-02-06T00:47:40.719009Z","steps":["trace[1707776961] 'process raft request'  (duration: 540.668237ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:40.719071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:40.177816Z","time spent":"541.217599ms","remote":"127.0.0.1:54470","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:935 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:47:40.719147Z","caller":"traceutil/trace.go:171","msg":"trace[448703935] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"539.858499ms","start":"2026-02-06T00:47:40.179282Z","end":"2026-02-06T00:47:40.71914Z","steps":["trace[448703935] 'process raft request'  (duration: 539.287547ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:40.719178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:47:40.179266Z","time spent":"539.894009ms","remote":"127.0.0.1:54470","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:936 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-06T00:47:40.719262Z","caller":"traceutil/trace.go:171","msg":"trace[1418012537] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"266.001563ms","start":"2026-02-06T00:47:40.453255Z","end":"2026-02-06T00:47:40.719257Z","steps":["trace[1418012537] 'process raft request'  (duration: 265.337569ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:40.886823Z","caller":"traceutil/trace.go:171","msg":"trace[1816317554] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"164.195587ms","start":"2026-02-06T00:47:40.722609Z","end":"2026-02-06T00:47:40.886804Z","steps":["trace[1816317554] 'process raft request'  (duration: 66.957161ms)","trace[1816317554] 'compare'  (duration: 96.905558ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:42.988289Z","caller":"traceutil/trace.go:171","msg":"trace[389093725] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:983; }","duration":"265.145334ms","start":"2026-02-06T00:47:42.723124Z","end":"2026-02-06T00:47:42.98827Z","steps":["trace[389093725] 'read index received'  (duration: 265.020632ms)","trace[389093725] 'applied index is now lower than readState.Index'  (duration: 124.202µs)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:42.988497Z","caller":"traceutil/trace.go:171","msg":"trace[1098854409] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"292.907954ms","start":"2026-02-06T00:47:42.695583Z","end":"2026-02-06T00:47:42.988491Z","steps":["trace[1098854409] 'process raft request'  (duration: 292.609778ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:42.988644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.519613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-06T00:47:42.988663Z","caller":"traceutil/trace.go:171","msg":"trace[83135290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:946; }","duration":"265.580044ms","start":"2026-02-06T00:47:42.723078Z","end":"2026-02-06T00:47:42.988658Z","steps":["trace[83135290] 'agreement among raft nodes before linearized reading'  (duration: 265.506552ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:42.988751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.202613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-06T00:47:42.988768Z","caller":"traceutil/trace.go:171","msg":"trace[70096923] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:946; }","duration":"264.255524ms","start":"2026-02-06T00:47:42.724509Z","end":"2026-02-06T00:47:42.988764Z","steps":["trace[70096923] 'agreement among raft nodes before linearized reading'  (duration: 264.216973ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:42.988972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.922472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-06T00:47:42.98899Z","caller":"traceutil/trace.go:171","msg":"trace[557272771] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:946; }","duration":"158.976313ms","start":"2026-02-06T00:47:42.830009Z","end":"2026-02-06T00:47:42.988986Z","steps":["trace[557272771] 'agreement among raft nodes before linearized reading'  (duration: 158.947932ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:45.120451Z","caller":"traceutil/trace.go:171","msg":"trace[706956912] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"110.59823ms","start":"2026-02-06T00:47:45.009837Z","end":"2026-02-06T00:47:45.120435Z","steps":["trace[706956912] 'process raft request'  (duration: 110.516278ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:45.133341Z","caller":"traceutil/trace.go:171","msg":"trace[148713177] linearizableReadLoop","detail":"{readStateIndex:992; appliedIndex:990; }","duration":"115.627079ms","start":"2026-02-06T00:47:45.017701Z","end":"2026-02-06T00:47:45.133328Z","steps":["trace[148713177] 'read index received'  (duration: 102.975452ms)","trace[148713177] 'applied index is now lower than readState.Index'  (duration: 12.650707ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:45.133518Z","caller":"traceutil/trace.go:171","msg":"trace[1414088230] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"117.071862ms","start":"2026-02-06T00:47:45.016438Z","end":"2026-02-06T00:47:45.13351Z","steps":["trace[1414088230] 'process raft request'  (duration: 116.789075ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:45.133615Z","caller":"traceutil/trace.go:171","msg":"trace[315380774] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"115.956557ms","start":"2026-02-06T00:47:45.017653Z","end":"2026-02-06T00:47:45.13361Z","steps":["trace[315380774] 'process raft request'  (duration: 115.64512ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:45.133703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.989488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:47:45.133722Z","caller":"traceutil/trace.go:171","msg":"trace[1168268020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:954; }","duration":"116.03558ms","start":"2026-02-06T00:47:45.017681Z","end":"2026-02-06T00:47:45.133717Z","steps":["trace[1168268020] 'agreement among raft nodes before linearized reading'  (duration: 115.993479ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:54.607005Z","caller":"traceutil/trace.go:171","msg":"trace[1733502061] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"100.18756ms","start":"2026-02-06T00:47:54.506795Z","end":"2026-02-06T00:47:54.606983Z","steps":["trace[1733502061] 'process raft request'  (duration: 100.032027ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:54.858429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.462652ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994905492 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/csinodes/instance\" mod_revision:20 > success:<request_put:<key:\"/registry/csinodes/instance\" value_size:762 >> failure:<request_range:<key:\"/registry/csinodes/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:47:54.858525Z","caller":"traceutil/trace.go:171","msg":"trace[99849172] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"237.008606ms","start":"2026-02-06T00:47:54.621497Z","end":"2026-02-06T00:47:54.858506Z","steps":["trace[99849172] 'process raft request'  (duration: 123.394121ms)","trace[99849172] 'compare'  (duration: 113.37127ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:55.41989Z","caller":"traceutil/trace.go:171","msg":"trace[1515232417] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"185.113126ms","start":"2026-02-06T00:47:55.234758Z","end":"2026-02-06T00:47:55.419871Z","steps":["trace[1515232417] 'process raft request'  (duration: 126.315834ms)","trace[1515232417] 'compare'  (duration: 58.622638ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:55.487501Z","caller":"traceutil/trace.go:171","msg":"trace[2093294148] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1034; }","duration":"134.954346ms","start":"2026-02-06T00:47:55.352527Z","end":"2026-02-06T00:47:55.487481Z","steps":["trace[2093294148] 'read index received'  (duration: 8.551738ms)","trace[2093294148] 'applied index is now lower than readState.Index'  (duration: 126.401828ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:47:55.487722Z","caller":"traceutil/trace.go:171","msg":"trace[1164149535] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"251.969565ms","start":"2026-02-06T00:47:55.235745Z","end":"2026-02-06T00:47:55.487715Z","steps":["trace[1164149535] 'process raft request'  (duration: 251.637198ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:55.487944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.408556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:47:55.487966Z","caller":"traceutil/trace.go:171","msg":"trace[1269413597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:995; }","duration":"135.465836ms","start":"2026-02-06T00:47:55.352494Z","end":"2026-02-06T00:47:55.487959Z","steps":["trace[1269413597] 'agreement among raft nodes before linearized reading'  (duration: 135.420295ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:47:55.74392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.910949ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994905505 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.19\" mod_revision:955 > success:<request_put:<key:\"/registry/masterleases/199.204.45.19\" value_size:66 lease:988148899994905503 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.19\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:47:55.744002Z","caller":"traceutil/trace.go:171","msg":"trace[509526210] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"236.921194ms","start":"2026-02-06T00:47:55.507064Z","end":"2026-02-06T00:47:55.743985Z","steps":["trace[509526210] 'process raft request'  (duration: 73.876422ms)","trace[509526210] 'compare'  (duration: 162.582222ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:47:56.336267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.462798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-06T00:47:56.336336Z","caller":"traceutil/trace.go:171","msg":"trace[1540286198] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:997; }","duration":"136.56939ms","start":"2026-02-06T00:47:56.19975Z","end":"2026-02-06T00:47:56.336319Z","steps":["trace[1540286198] 'count revisions from in-memory index tree'  (duration: 136.413607ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:47:59.422875Z","caller":"traceutil/trace.go:171","msg":"trace[49627736] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"138.116095ms","start":"2026-02-06T00:47:59.284729Z","end":"2026-02-06T00:47:59.422845Z","steps":["trace[49627736] 'process raft request'  (duration: 137.944171ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:50:01.989446Z","caller":"traceutil/trace.go:171","msg":"trace[645123847] transaction","detail":"{read_only:false; response_revision:1597; number_of_response:1; }","duration":"105.974925ms","start":"2026-02-06T00:50:01.883448Z","end":"2026-02-06T00:50:01.989423Z","steps":["trace[645123847] 'process raft request'  (duration: 105.848882ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:50:02.13784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.04583ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994907040 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1591 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:50:02.138179Z","caller":"traceutil/trace.go:171","msg":"trace[1806549679] transaction","detail":"{read_only:false; response_revision:1598; number_of_response:1; }","duration":"120.308903ms","start":"2026-02-06T00:50:02.017849Z","end":"2026-02-06T00:50:02.138158Z","steps":["trace[1806549679] 'process raft request'  (duration: 11.876014ms)","trace[1806549679] 'compare'  (duration: 107.958458ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:50:02.932937Z","caller":"traceutil/trace.go:171","msg":"trace[992999963] transaction","detail":"{read_only:false; response_revision:1601; number_of_response:1; }","duration":"207.810738ms","start":"2026-02-06T00:50:02.72511Z","end":"2026-02-06T00:50:02.932921Z","steps":["trace[992999963] 'process raft request'  (duration: 207.605082ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:50:03.047702Z","caller":"traceutil/trace.go:171","msg":"trace[1055696756] transaction","detail":"{read_only:false; response_revision:1602; number_of_response:1; }","duration":"110.627638ms","start":"2026-02-06T00:50:02.937056Z","end":"2026-02-06T00:50:03.047684Z","steps":["trace[1055696756] 'process raft request'  (duration: 68.399759ms)","trace[1055696756] 'compare'  (duration: 41.910481ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:50:04.321858Z","caller":"traceutil/trace.go:171","msg":"trace[1963969249] transaction","detail":"{read_only:false; response_revision:1612; number_of_response:1; }","duration":"102.844564ms","start":"2026-02-06T00:50:04.218992Z","end":"2026-02-06T00:50:04.321836Z","steps":["trace[1963969249] 'process raft request'  (duration: 102.365653ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:50:24.134241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.407412ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994907309 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:1688 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:449 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:50:24.134302Z","caller":"traceutil/trace.go:171","msg":"trace[1146057074] linearizableReadLoop","detail":"{readStateIndex:1771; appliedIndex:1770; }","duration":"217.697301ms","start":"2026-02-06T00:50:23.916595Z","end":"2026-02-06T00:50:24.134292Z","steps":["trace[1146057074] 'read index received'  (duration: 79.106894ms)","trace[1146057074] 'applied index is now lower than readState.Index'  (duration: 138.589857ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:50:24.134534Z","caller":"traceutil/trace.go:171","msg":"trace[950296237] transaction","detail":"{read_only:false; response_revision:1700; number_of_response:1; }","duration":"252.000797ms","start":"2026-02-06T00:50:23.882512Z","end":"2026-02-06T00:50:24.134513Z","steps":["trace[950296237] 'process raft request'  (duration: 113.274238ms)","trace[950296237] 'compare'  (duration: 138.26822ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:50:24.13471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.116401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-06T00:50:24.134729Z","caller":"traceutil/trace.go:171","msg":"trace[291387053] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1700; }","duration":"218.159351ms","start":"2026-02-06T00:50:23.916565Z","end":"2026-02-06T00:50:24.134724Z","steps":["trace[291387053] 'agreement among raft nodes before linearized reading'  (duration: 218.12228ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:50:24.138971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.136526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:50:24.139006Z","caller":"traceutil/trace.go:171","msg":"trace[684339210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1701; }","duration":"123.219698ms","start":"2026-02-06T00:50:24.015778Z","end":"2026-02-06T00:50:24.138997Z","steps":["trace[684339210] 'agreement among raft nodes before linearized reading'  (duration: 123.137756ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:50:24.278839Z","caller":"traceutil/trace.go:171","msg":"trace[697257722] transaction","detail":"{read_only:false; response_revision:1702; number_of_response:1; }","duration":"134.843633ms","start":"2026-02-06T00:50:24.143971Z","end":"2026-02-06T00:50:24.278815Z","steps":["trace[697257722] 'process raft request'  (duration: 133.443842ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:50:24.779778Z","caller":"traceutil/trace.go:171","msg":"trace[400798375] transaction","detail":"{read_only:false; response_revision:1704; number_of_response:1; }","duration":"288.721146ms","start":"2026-02-06T00:50:24.49103Z","end":"2026-02-06T00:50:24.779752Z","steps":["trace[400798375] 'process raft request'  (duration: 288.572003ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:50:28.391209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.978128ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994907356 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1708 > success:<request_put:<key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" value_size:537 >> failure:<request_range:<key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:50:28.391297Z","caller":"traceutil/trace.go:171","msg":"trace[912999451] linearizableReadLoop","detail":"{readStateIndex:1788; appliedIndex:1787; }","duration":"100.989957ms","start":"2026-02-06T00:50:28.290292Z","end":"2026-02-06T00:50:28.391282Z","steps":["trace[912999451] 'read index received'  (duration: 29.801µs)","trace[912999451] 'applied index is now lower than readState.Index'  (duration: 100.958916ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:50:28.391731Z","caller":"traceutil/trace.go:171","msg":"trace[768549605] transaction","detail":"{read_only:false; response_revision:1716; number_of_response:1; }","duration":"228.396026ms","start":"2026-02-06T00:50:28.163318Z","end":"2026-02-06T00:50:28.391714Z","steps":["trace[768549605] 'process raft request'  (duration: 91.807564ms)","trace[768549605] 'compare'  (duration: 135.899426ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:50:28.392025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.727064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-06T00:50:28.392064Z","caller":"traceutil/trace.go:171","msg":"trace[1740275901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1716; }","duration":"101.797395ms","start":"2026-02-06T00:50:28.290257Z","end":"2026-02-06T00:50:28.392054Z","steps":["trace[1740275901] 'agreement among raft nodes before linearized reading'  (duration: 101.673922ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:50:28.670018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.752323ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994907360 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1710 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:50:28.67028Z","caller":"traceutil/trace.go:171","msg":"trace[306625606] transaction","detail":"{read_only:false; response_revision:1720; number_of_response:1; }","duration":"198.845395ms","start":"2026-02-06T00:50:28.471414Z","end":"2026-02-06T00:50:28.670259Z","steps":["trace[306625606] 'process raft request'  (duration: 198.788744ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:50:28.670311Z","caller":"traceutil/trace.go:171","msg":"trace[1417032518] transaction","detail":"{read_only:false; response_revision:1718; number_of_response:1; }","duration":"270.457805ms","start":"2026-02-06T00:50:28.39982Z","end":"2026-02-06T00:50:28.670277Z","steps":["trace[1417032518] 'process raft request'  (duration: 168.370124ms)","trace[1417032518] 'compare'  (duration: 101.641161ms)"],"step_count":2}
{"level":"info","ts":"2026-02-06T00:50:28.67059Z","caller":"traceutil/trace.go:171","msg":"trace[1492124887] transaction","detail":"{read_only:false; response_revision:1719; number_of_response:1; }","duration":"269.257867ms","start":"2026-02-06T00:50:28.401321Z","end":"2026-02-06T00:50:28.670579Z","steps":["trace[1492124887] 'process raft request'  (duration: 268.804138ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:50:28.670712Z","caller":"traceutil/trace.go:171","msg":"trace[1374218507] linearizableReadLoop","detail":"{readStateIndex:1791; appliedIndex:1789; }","duration":"202.73512ms","start":"2026-02-06T00:50:28.467966Z","end":"2026-02-06T00:50:28.670701Z","steps":["trace[1374218507] 'read index received'  (duration: 100.23365ms)","trace[1374218507] 'applied index is now lower than readState.Index'  (duration: 102.5006ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:50:28.6709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.387107ms","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-02-06T00:50:28.670932Z","caller":"traceutil/trace.go:171","msg":"trace[2139896102] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1720; }","duration":"238.456909ms","start":"2026-02-06T00:50:28.432465Z","end":"2026-02-06T00:50:28.670921Z","steps":["trace[2139896102] 'agreement among raft nodes before linearized reading'  (duration: 238.334676ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:50:28.978699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.686451ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994907367 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1697 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:439 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-06T00:50:28.978823Z","caller":"traceutil/trace.go:171","msg":"trace[5942486] linearizableReadLoop","detail":"{readStateIndex:1794; appliedIndex:1793; }","duration":"186.433721ms","start":"2026-02-06T00:50:28.792374Z","end":"2026-02-06T00:50:28.978807Z","steps":["trace[5942486] 'read index received'  (duration: 36.481355ms)","trace[5942486] 'applied index is now lower than readState.Index'  (duration: 149.951216ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:50:28.978984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.616125ms","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-02-06T00:50:28.979017Z","caller":"traceutil/trace.go:171","msg":"trace[1287542526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1722; }","duration":"186.648546ms","start":"2026-02-06T00:50:28.79236Z","end":"2026-02-06T00:50:28.979008Z","steps":["trace[1287542526] 'agreement among raft nodes before linearized reading'  (duration: 186.507792ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:50:28.979274Z","caller":"traceutil/trace.go:171","msg":"trace[2064429431] transaction","detail":"{read_only:false; response_revision:1722; number_of_response:1; }","duration":"302.46599ms","start":"2026-02-06T00:50:28.676794Z","end":"2026-02-06T00:50:28.97926Z","steps":["trace[2064429431] 'process raft request'  (duration: 152.140666ms)","trace[2064429431] 'compare'  (duration: 149.595628ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:50:28.979338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T00:50:28.676788Z","time spent":"302.518951ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1697 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:439 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-02-06T00:50:28.978166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.222423ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:50:28.999024Z","caller":"traceutil/trace.go:171","msg":"trace[1885459050] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1721; }","duration":"147.069322ms","start":"2026-02-06T00:50:28.851889Z","end":"2026-02-06T00:50:28.998958Z","steps":["trace[1885459050] 'range keys from in-memory index tree'  (duration: 126.199963ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:50:29.968307Z","caller":"traceutil/trace.go:171","msg":"trace[1809891225] transaction","detail":"{read_only:false; response_revision:1725; number_of_response:1; }","duration":"162.476292ms","start":"2026-02-06T00:50:29.805808Z","end":"2026-02-06T00:50:29.968284Z","steps":["trace[1809891225] 'process raft request'  (duration: 162.345349ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:50:32.92049Z","caller":"traceutil/trace.go:171","msg":"trace[568964319] transaction","detail":"{read_only:false; response_revision:1736; number_of_response:1; }","duration":"131.208514ms","start":"2026-02-06T00:50:32.78926Z","end":"2026-02-06T00:50:32.920468Z","steps":["trace[568964319] 'process raft request'  (duration: 130.440657ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:50:40.185512Z","caller":"traceutil/trace.go:171","msg":"trace[1275590244] transaction","detail":"{read_only:false; response_revision:1771; number_of_response:1; }","duration":"102.409409ms","start":"2026-02-06T00:50:40.08307Z","end":"2026-02-06T00:50:40.18548Z","steps":["trace[1275590244] 'process raft request'  (duration: 102.286495ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-06T00:50:40.853834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.518409ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988148899994907500 > lease_revoke:<id:0db69c306963b2bb>","response":"size:28"}
{"level":"info","ts":"2026-02-06T00:50:40.85394Z","caller":"traceutil/trace.go:171","msg":"trace[1135096967] linearizableReadLoop","detail":"{readStateIndex:1847; appliedIndex:1846; }","duration":"263.229354ms","start":"2026-02-06T00:50:40.590684Z","end":"2026-02-06T00:50:40.853913Z","steps":["trace[1135096967] 'read index received'  (duration: 156.592183ms)","trace[1135096967] 'applied index is now lower than readState.Index'  (duration: 106.635701ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:50:40.854299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.602712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-06T00:50:40.854338Z","caller":"traceutil/trace.go:171","msg":"trace[254390491] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1772; }","duration":"263.692044ms","start":"2026-02-06T00:50:40.590635Z","end":"2026-02-06T00:50:40.854328Z","steps":["trace[254390491] 'agreement among raft nodes before linearized reading'  (duration: 263.538521ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:50:41.074966Z","caller":"traceutil/trace.go:171","msg":"trace[1759285052] linearizableReadLoop","detail":"{readStateIndex:1849; appliedIndex:1848; }","duration":"104.748539ms","start":"2026-02-06T00:50:40.970134Z","end":"2026-02-06T00:50:41.074883Z","steps":["trace[1759285052] 'read index received'  (duration: 44.088321ms)","trace[1759285052] 'applied index is now lower than readState.Index'  (duration: 60.658318ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:50:41.075808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.649469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"}
{"level":"info","ts":"2026-02-06T00:50:41.076434Z","caller":"traceutil/trace.go:171","msg":"trace[790353779] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1774; }","duration":"106.320535ms","start":"2026-02-06T00:50:40.970093Z","end":"2026-02-06T00:50:41.076414Z","steps":["trace[790353779] 'agreement among raft nodes before linearized reading'  (duration: 105.556307ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:50:41.08454Z","caller":"traceutil/trace.go:171","msg":"trace[738023246] transaction","detail":"{read_only:false; response_revision:1774; number_of_response:1; }","duration":"223.99966ms","start":"2026-02-06T00:50:40.860504Z","end":"2026-02-06T00:50:41.084503Z","steps":["trace[738023246] 'process raft request'  (duration: 153.841603ms)","trace[738023246] 'compare'  (duration: 59.980583ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:51:13.167575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.361959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-06T00:51:13.167783Z","caller":"traceutil/trace.go:171","msg":"trace[401075142] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1947; }","duration":"152.628215ms","start":"2026-02-06T00:51:13.01514Z","end":"2026-02-06T00:51:13.167769Z","steps":["trace[401075142] 'range keys from in-memory index tree'  (duration: 152.259147ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:51:49.780327Z","caller":"traceutil/trace.go:171","msg":"trace[377005547] linearizableReadLoop","detail":"{readStateIndex:2220; appliedIndex:2219; }","duration":"103.468694ms","start":"2026-02-06T00:51:49.67684Z","end":"2026-02-06T00:51:49.780309Z","steps":["trace[377005547] 'read index received'  (duration: 47.501239ms)","trace[377005547] 'applied index is now lower than readState.Index'  (duration: 55.966945ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-06T00:51:49.780488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.628557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-7v99m\" ","response":"range_response_count:1 size:12538"}
{"level":"info","ts":"2026-02-06T00:51:49.78052Z","caller":"traceutil/trace.go:171","msg":"trace[929341165] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-7v99m; range_end:; response_count:1; response_revision:2131; }","duration":"103.696848ms","start":"2026-02-06T00:51:49.676815Z","end":"2026-02-06T00:51:49.780512Z","steps":["trace[929341165] 'agreement among raft nodes before linearized reading'  (duration: 103.568675ms)"],"step_count":1}
{"level":"info","ts":"2026-02-06T00:51:49.780719Z","caller":"traceutil/trace.go:171","msg":"trace[684121782] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"105.827815ms","start":"2026-02-06T00:51:49.674883Z","end":"2026-02-06T00:51:49.780711Z","steps":["trace[684121782] 'process raft request'  (duration: 49.496142ms)","trace[684121782] 'compare'  (duration: 55.830473ms)"],"step_count":2}