{"level":"warn","ts":"2026-03-03T10:56:47.665708Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-03T10:56:47.665811Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.194: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.19.213.194:2380","--initial-cluster=instance=https://199.19.213.194:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.194:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.194:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-03T10:56:47.665981Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-03T10:56:47.666002Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.194:2380"]}
{"level":"info","ts":"2026-03-03T10:56:47.666028Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-03T10:56:47.66694Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.194:2379"]}
{"level":"info","ts":"2026-03-03T10:56:47.667038Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.194:2380"],"listen-peer-urls":["https://199.19.213.194:2380"],"advertise-client-urls":["https://199.19.213.194:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.194:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.194:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-03T10:56:47.672532Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.240185ms"}
{"level":"info","ts":"2026-03-03T10:56:47.680915Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1444e0f5dfca45ef","cluster-id":"46f0df2abd5471c9"}
{"level":"info","ts":"2026-03-03T10:56:47.680996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef switched to configuration voters=()"}
{"level":"info","ts":"2026-03-03T10:56:47.681022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became follower at term 0"}
{"level":"info","ts":"2026-03-03T10:56:47.681035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1444e0f5dfca45ef [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-03T10:56:47.681047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became follower at term 1"}
{"level":"info","ts":"2026-03-03T10:56:47.681086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef switched to configuration voters=(1460539525801068015)"}
{"level":"warn","ts":"2026-03-03T10:56:47.692295Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-03T10:56:47.693815Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-03T10:56:47.694918Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-03-03T10:56:47.697009Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1444e0f5dfca45ef","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-03T10:56:47.697649Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1444e0f5dfca45ef","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-03T10:56:47.698385Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-03T10:56:47.698464Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-03T10:56:47.698477Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-03T10:56:47.69901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef switched to configuration voters=(1460539525801068015)"}
{"level":"info","ts":"2026-03-03T10:56:47.69914Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"46f0df2abd5471c9","local-member-id":"1444e0f5dfca45ef","added-peer-id":"1444e0f5dfca45ef","added-peer-peer-urls":["https://199.19.213.194:2380"]}
{"level":"info","ts":"2026-03-03T10:56:47.702779Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-03T10:56:47.702868Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.194:2380"}
{"level":"info","ts":"2026-03-03T10:56:47.702903Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.194:2380"}
{"level":"info","ts":"2026-03-03T10:56:47.703077Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1444e0f5dfca45ef","initial-advertise-peer-urls":["https://199.19.213.194:2380"],"listen-peer-urls":["https://199.19.213.194:2380"],"advertise-client-urls":["https://199.19.213.194:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.194:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-03T10:56:47.703129Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-03T10:56:48.681468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef is starting a new election at term 1"}
{"level":"info","ts":"2026-03-03T10:56:48.681528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-03T10:56:48.681553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef received MsgPreVoteResp from 1444e0f5dfca45ef at term 1"}
{"level":"info","ts":"2026-03-03T10:56:48.681573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became candidate at term 2"}
{"level":"info","ts":"2026-03-03T10:56:48.681602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef received MsgVoteResp from 1444e0f5dfca45ef at term 2"}
{"level":"info","ts":"2026-03-03T10:56:48.681625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became leader at term 2"}
{"level":"info","ts":"2026-03-03T10:56:48.681659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1444e0f5dfca45ef elected leader 1444e0f5dfca45ef at term 2"}
{"level":"info","ts":"2026-03-03T10:56:48.682516Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-03T10:56:48.683277Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1444e0f5dfca45ef","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.194:2379]}","request-path":"/0/members/1444e0f5dfca45ef/attributes","cluster-id":"46f0df2abd5471c9","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-03T10:56:48.683283Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-03T10:56:48.683317Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-03T10:56:48.683451Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-03T10:56:48.683471Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-03T10:56:48.684893Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"46f0df2abd5471c9","local-member-id":"1444e0f5dfca45ef","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-03T10:56:48.68494Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.194:2379"}
{"level":"info","ts":"2026-03-03T10:56:48.685009Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-03T10:56:48.685097Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-03T10:56:48.686091Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-03T10:56:50.199206Z","caller":"traceutil/trace.go:171","msg":"trace[1239187438] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"337.442817ms","start":"2026-03-03T10:56:49.861739Z","end":"2026-03-03T10:56:50.199182Z","steps":["trace[1239187438] 'read index received'  (duration: 337.366436ms)","trace[1239187438] 'applied index is now lower than readState.Index'  (duration: 75.371µs)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:56:50.19927Z","caller":"traceutil/trace.go:171","msg":"trace[1762866344] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"341.174398ms","start":"2026-03-03T10:56:49.858053Z","end":"2026-03-03T10:56:50.199227Z","steps":["trace[1762866344] 'process raft request'  (duration: 340.891021ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:50.199395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.630082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-03T10:56:50.199451Z","caller":"traceutil/trace.go:171","msg":"trace[1172705091] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:2; }","duration":"337.725355ms","start":"2026-03-03T10:56:49.861715Z","end":"2026-03-03T10:56:50.19944Z","steps":["trace[1172705091] 'agreement among raft nodes before linearized reading'  (duration: 337.594992ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:50.199497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.861705Z","time spent":"337.783836ms","remote":"127.0.0.1:53558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":26,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-03-03T10:56:50.200032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.858041Z","time spent":"341.322261ms","remote":"127.0.0.1:53438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"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-03-03T10:56:50.69973Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039418802138530176,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-03T10:56:51.200171Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039418802138530176,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-03T10:56:51.441453Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.242389675s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-03T10:56:51.442119Z","caller":"traceutil/trace.go:171","msg":"trace[133472938] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.509318213s","start":"2026-03-03T10:56:49.932778Z","end":"2026-03-03T10:56:51.442096Z","steps":["trace[133472938] 'process raft request'  (duration: 1.509071937s)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:56:51.442203Z","caller":"traceutil/trace.go:171","msg":"trace[2067873143] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.507309245s","start":"2026-03-03T10:56:49.934859Z","end":"2026-03-03T10:56:51.442168Z","steps":["trace[2067873143] 'process raft request'  (duration: 1.507030328s)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:56:51.442209Z","caller":"traceutil/trace.go:171","msg":"trace[315839888] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.507274103s","start":"2026-03-03T10:56:49.934915Z","end":"2026-03-03T10:56:51.442189Z","steps":["trace[315839888] 'process raft request'  (duration: 1.507002437s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.442264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.93276Z","time spent":"1.509425125s","remote":"127.0.0.1:53826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>"}
{"level":"warn","ts":"2026-03-03T10:56:51.44228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.934889Z","time spent":"1.507357315s","remote":"127.0.0.1:53906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"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":"warn","ts":"2026-03-03T10:56:51.442303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.934847Z","time spent":"1.507397826s","remote":"127.0.0.1:53906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"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-03-03T10:56:51.442444Z","caller":"traceutil/trace.go:171","msg":"trace[1116706528] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.578795388s","start":"2026-03-03T10:56:49.863544Z","end":"2026-03-03T10:56:51.442339Z","steps":["trace[1116706528] 'process raft request'  (duration: 1.578163873s)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:56:51.442517Z","caller":"traceutil/trace.go:171","msg":"trace[1878026659] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.50752699s","start":"2026-03-03T10:56:49.934976Z","end":"2026-03-03T10:56:51.442503Z","steps":["trace[1878026659] 'process raft request'  (duration: 1.506963606s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.442589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.934967Z","time spent":"1.507579291s","remote":"127.0.0.1:53906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"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":"warn","ts":"2026-03-03T10:56:51.442628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.863535Z","time spent":"1.579008073s","remote":"127.0.0.1:53636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-qdcdn\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-qdcdn\" value_size:791 >> failure:<>"}
{"level":"info","ts":"2026-03-03T10:56:51.442931Z","caller":"traceutil/trace.go:171","msg":"trace[132235600] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.507814637s","start":"2026-03-03T10:56:49.935106Z","end":"2026-03-03T10:56:51.442921Z","steps":["trace[132235600] 'process raft request'  (duration: 1.507338985s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.444185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.935096Z","time spent":"1.509040986s","remote":"127.0.0.1:53906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"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-03-03T10:56:51.442938Z","caller":"traceutil/trace.go:171","msg":"trace[1781572364] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"1.243631905s","start":"2026-03-03T10:56:50.199287Z","end":"2026-03-03T10:56:51.442919Z","steps":["trace[1781572364] 'read index received'  (duration: 1.242347354s)","trace[1781572364] 'applied index is now lower than readState.Index'  (duration: 1.283561ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:56:51.444504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.834709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-03T10:56:51.443027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.581202465s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-03T10:56:51.444555Z","caller":"traceutil/trace.go:171","msg":"trace[70224826] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10; }","duration":"320.946513ms","start":"2026-03-03T10:56:51.123596Z","end":"2026-03-03T10:56:51.444543Z","steps":["trace[70224826] 'agreement among raft nodes before linearized reading'  (duration: 320.869111ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:56:51.444571Z","caller":"traceutil/trace.go:171","msg":"trace[1960476298] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:10; }","duration":"1.582755823s","start":"2026-03-03T10:56:49.861797Z","end":"2026-03-03T10:56:51.444553Z","steps":["trace[1960476298] 'agreement among raft nodes before linearized reading'  (duration: 1.581165515s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.44459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:51.123571Z","time spent":"321.012744ms","remote":"127.0.0.1:53374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-03T10:56:51.44462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.861789Z","time spent":"1.582817894s","remote":"127.0.0.1:53444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":26,"request content":"key:\"/registry/ranges/servicenodeports\" "}
{"level":"warn","ts":"2026-03-03T10:56:51.444635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.09283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-03T10:56:51.444517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.230681335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-03T10:56:51.444715Z","caller":"traceutil/trace.go:171","msg":"trace[365050866] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:10; }","duration":"612.194082ms","start":"2026-03-03T10:56:50.832513Z","end":"2026-03-03T10:56:51.444707Z","steps":["trace[365050866] 'agreement among raft nodes before linearized reading'  (duration: 612.019018ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.444792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:50.83251Z","time spent":"612.275614ms","remote":"127.0.0.1:53714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "}
{"level":"warn","ts":"2026-03-03T10:56:51.443089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.528209985s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-03T10:56:51.444926Z","caller":"traceutil/trace.go:171","msg":"trace[828602787] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.530060209s","start":"2026-03-03T10:56:49.914851Z","end":"2026-03-03T10:56:51.444911Z","steps":["trace[828602787] 'agreement among raft nodes before linearized reading'  (duration: 1.528197285s)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:56:51.444743Z","caller":"traceutil/trace.go:171","msg":"trace[47220952] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"1.23093278s","start":"2026-03-03T10:56:50.2138Z","end":"2026-03-03T10:56:51.444733Z","steps":["trace[47220952] 'agreement among raft nodes before linearized reading'  (duration: 1.230642453s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.443114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.509733782s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-03T10:56:51.444979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.914844Z","time spent":"1.530122301s","remote":"127.0.0.1:53492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-03-03T10:56:51.445055Z","caller":"traceutil/trace.go:171","msg":"trace[1695296269] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.511670009s","start":"2026-03-03T10:56:49.933374Z","end":"2026-03-03T10:56:51.445044Z","steps":["trace[1695296269] 'agreement among raft nodes before linearized reading'  (duration: 1.509719972s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.445101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.933344Z","time spent":"1.511748911s","remote":"127.0.0.1:53492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-03-03T10:56:51.443135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.528434561s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-03T10:56:51.44526Z","caller":"traceutil/trace.go:171","msg":"trace[1694049814] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.530542961s","start":"2026-03-03T10:56:49.914674Z","end":"2026-03-03T10:56:51.445217Z","steps":["trace[1694049814] 'agreement among raft nodes before linearized reading'  (duration: 1.52844362s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.445365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.914656Z","time spent":"1.530695175s","remote":"127.0.0.1:53492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-03-03T10:56:51.445009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:50.213778Z","time spent":"1.231207437s","remote":"127.0.0.1:53770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"warn","ts":"2026-03-03T10:56:51.443154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.511350831s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.194\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-03T10:56:51.445491Z","caller":"traceutil/trace.go:171","msg":"trace[2032101222] range","detail":"{range_begin:/registry/masterleases/199.19.213.194; range_end:; response_count:0; response_revision:10; }","duration":"1.513716428s","start":"2026-03-03T10:56:49.931757Z","end":"2026-03-03T10:56:51.445473Z","steps":["trace[2032101222] 'agreement among raft nodes before linearized reading'  (duration: 1.511376732s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.445412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.484669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-03T10:56:51.445567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.931735Z","time spent":"1.51380262s","remote":"127.0.0.1:53416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.19.213.194\" "}
{"level":"info","ts":"2026-03-03T10:56:51.445599Z","caller":"traceutil/trace.go:171","msg":"trace[99128139] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:10; }","duration":"613.207016ms","start":"2026-03-03T10:56:50.832336Z","end":"2026-03-03T10:56:51.445543Z","steps":["trace[99128139] 'agreement among raft nodes before linearized reading'  (duration: 612.330936ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:56:51.443206Z","caller":"traceutil/trace.go:171","msg":"trace[462955736] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.498525214s","start":"2026-03-03T10:56:49.944663Z","end":"2026-03-03T10:56:51.443188Z","steps":["trace[462955736] 'process raft request'  (duration: 1.498219487s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.445703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:50.832322Z","time spent":"613.342979ms","remote":"127.0.0.1:53732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "}
{"level":"warn","ts":"2026-03-03T10:56:51.445741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.944653Z","time spent":"1.501055144s","remote":"127.0.0.1:53558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3125 >> failure:<>"}
{"level":"info","ts":"2026-03-03T10:56:51.44325Z","caller":"traceutil/trace.go:171","msg":"trace[637070258] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.507579831s","start":"2026-03-03T10:56:49.935661Z","end":"2026-03-03T10:56:51.443241Z","steps":["trace[637070258] 'process raft request'  (duration: 1.507177762s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.443272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459627451s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-03T10:56:51.44586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.935644Z","time spent":"1.510184833s","remote":"127.0.0.1:53906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"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-03-03T10:56:51.445873Z","caller":"traceutil/trace.go:171","msg":"trace[28760650] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.462242124s","start":"2026-03-03T10:56:49.983615Z","end":"2026-03-03T10:56:51.445857Z","steps":["trace[28760650] 'agreement among raft nodes before linearized reading'  (duration: 1.459638912s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.443955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.509460145s","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":"warn","ts":"2026-03-03T10:56:51.445921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.983601Z","time spent":"1.462307465s","remote":"127.0.0.1:53492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-03-03T10:56:51.445938Z","caller":"traceutil/trace.go:171","msg":"trace[1579765429] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"1.512364046s","start":"2026-03-03T10:56:49.93356Z","end":"2026-03-03T10:56:51.445925Z","steps":["trace[1579765429] 'agreement among raft nodes before linearized reading'  (duration: 1.509423995s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.445975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.933554Z","time spent":"1.512410817s","remote":"127.0.0.1:53472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"warn","ts":"2026-03-03T10:56:51.443063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.521408403s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-03T10:56:51.446078Z","caller":"traceutil/trace.go:171","msg":"trace[93252794] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.524454725s","start":"2026-03-03T10:56:49.921612Z","end":"2026-03-03T10:56:51.446067Z","steps":["trace[93252794] 'agreement among raft nodes before linearized reading'  (duration: 1.521397762s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:56:51.446119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:56:49.921594Z","time spent":"1.524516697s","remote":"127.0.0.1:53492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-03-03T10:57:14.955722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.012378513s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-03T10:57:14.955814Z","caller":"traceutil/trace.go:171","msg":"trace[439143893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:460; }","duration":"1.012500156s","start":"2026-03-03T10:57:13.943294Z","end":"2026-03-03T10:57:14.955794Z","steps":["trace[439143893] 'range keys from in-memory index tree'  (duration: 1.012297121s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:14.955814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.702316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-03T10:57:14.955793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.479186351s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-03T10:57:14.955858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:13.943281Z","time spent":"1.012566698s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-03T10:57:14.955871Z","caller":"traceutil/trace.go:171","msg":"trace[1798540584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:460; }","duration":"635.772238ms","start":"2026-03-03T10:57:14.32008Z","end":"2026-03-03T10:57:14.955853Z","steps":["trace[1798540584] 'range keys from in-memory index tree'  (duration: 635.645974ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:14.955869Z","caller":"traceutil/trace.go:171","msg":"trace[917742496] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:460; }","duration":"1.479315174s","start":"2026-03-03T10:57:13.476541Z","end":"2026-03-03T10:57:14.955857Z","steps":["trace[917742496] 'range keys from in-memory index tree'  (duration: 1.479085778s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:14.9559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:14.32007Z","time spent":"635.823369ms","remote":"127.0.0.1:53652","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-03-03T10:57:14.955914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:13.476518Z","time spent":"1.479388856s","remote":"127.0.0.1:53374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-03T10:57:14.95705Z","caller":"traceutil/trace.go:171","msg":"trace[984490404] linearizableReadLoop","detail":"{readStateIndex:477; appliedIndex:476; }","duration":"272.178573ms","start":"2026-03-03T10:57:14.684858Z","end":"2026-03-03T10:57:14.957037Z","steps":["trace[984490404] 'read index received'  (duration: 272.05991ms)","trace[984490404] 'applied index is now lower than readState.Index'  (duration: 118.093µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:57:14.957112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.257185ms","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-03-03T10:57:14.957134Z","caller":"traceutil/trace.go:171","msg":"trace[1842168586] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:461; }","duration":"272.315566ms","start":"2026-03-03T10:57:14.684811Z","end":"2026-03-03T10:57:14.957127Z","steps":["trace[1842168586] 'agreement among raft nodes before linearized reading'  (duration: 272.269455ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:14.957136Z","caller":"traceutil/trace.go:171","msg":"trace[1194417596] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"374.597387ms","start":"2026-03-03T10:57:14.582495Z","end":"2026-03-03T10:57:14.957093Z","steps":["trace[1194417596] 'process raft request'  (duration: 374.469554ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:14.957304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:14.58248Z","time spent":"374.7335ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:410 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-03-03T10:57:19.354492Z","caller":"traceutil/trace.go:171","msg":"trace[1056472998] linearizableReadLoop","detail":"{readStateIndex:522; appliedIndex:521; }","duration":"335.565262ms","start":"2026-03-03T10:57:19.018906Z","end":"2026-03-03T10:57:19.354471Z","steps":["trace[1056472998] 'read index received'  (duration: 335.387557ms)","trace[1056472998] 'applied index is now lower than readState.Index'  (duration: 176.885µs)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:57:19.354626Z","caller":"traceutil/trace.go:171","msg":"trace[1530886162] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"362.362133ms","start":"2026-03-03T10:57:18.992219Z","end":"2026-03-03T10:57:19.354581Z","steps":["trace[1530886162] 'process raft request'  (duration: 362.132168ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:19.354724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.588698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-03-03T10:57:19.354732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.789037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-03T10:57:19.354813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:18.992202Z","time spent":"362.505887ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:466 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:57:19.354818Z","caller":"traceutil/trace.go:171","msg":"trace[111168495] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:504; }","duration":"335.92053ms","start":"2026-03-03T10:57:19.018877Z","end":"2026-03-03T10:57:19.354797Z","steps":["trace[111168495] 'agreement among raft nodes before linearized reading'  (duration: 335.726536ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:19.354779Z","caller":"traceutil/trace.go:171","msg":"trace[225519951] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:504; }","duration":"334.675601ms","start":"2026-03-03T10:57:19.020085Z","end":"2026-03-03T10:57:19.354761Z","steps":["trace[225519951] 'agreement among raft nodes before linearized reading'  (duration: 334.562408ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:19.354868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:19.018866Z","time spent":"335.994132ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-03T10:57:19.354873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:19.020076Z","time spent":"334.786023ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-03T10:57:19.581123Z","caller":"traceutil/trace.go:171","msg":"trace[2054802784] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"222.361869ms","start":"2026-03-03T10:57:19.35874Z","end":"2026-03-03T10:57:19.581102Z","steps":["trace[2054802784] 'process raft request'  (duration: 222.242666ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:19.596174Z","caller":"traceutil/trace.go:171","msg":"trace[1447985541] linearizableReadLoop","detail":"{readStateIndex:524; appliedIndex:523; }","duration":"198.696452ms","start":"2026-03-03T10:57:19.397452Z","end":"2026-03-03T10:57:19.596149Z","steps":["trace[1447985541] 'read index received'  (duration: 183.678822ms)","trace[1447985541] 'applied index is now lower than readState.Index'  (duration: 15.01669ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:57:19.596212Z","caller":"traceutil/trace.go:171","msg":"trace[687928753] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"236.830346ms","start":"2026-03-03T10:57:19.359366Z","end":"2026-03-03T10:57:19.596197Z","steps":["trace[687928753] 'process raft request'  (duration: 236.659622ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:19.596348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.869607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"}
{"level":"warn","ts":"2026-03-03T10:57:19.596411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.150216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-03T10:57:19.596428Z","caller":"traceutil/trace.go:171","msg":"trace[1342137447] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:506; }","duration":"199.04417ms","start":"2026-03-03T10:57:19.397364Z","end":"2026-03-03T10:57:19.596408Z","steps":["trace[1342137447] 'agreement among raft nodes before linearized reading'  (duration: 198.881136ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:19.596466Z","caller":"traceutil/trace.go:171","msg":"trace[418479600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:506; }","duration":"187.237237ms","start":"2026-03-03T10:57:19.409214Z","end":"2026-03-03T10:57:19.596451Z","steps":["trace[418479600] 'agreement among raft nodes before linearized reading'  (duration: 187.075463ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:19.596691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.625124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:57:19.596831Z","caller":"traceutil/trace.go:171","msg":"trace[114894314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:506; }","duration":"118.809648ms","start":"2026-03-03T10:57:19.477989Z","end":"2026-03-03T10:57:19.596798Z","steps":["trace[114894314] 'agreement among raft nodes before linearized reading'  (duration: 118.558952ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:19.729935Z","caller":"traceutil/trace.go:171","msg":"trace[81361646] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"128.198822ms","start":"2026-03-03T10:57:19.601695Z","end":"2026-03-03T10:57:19.729894Z","steps":["trace[81361646] 'process raft request'  (duration: 104.183007ms)","trace[81361646] 'compare'  (duration: 23.841741ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:57:19.786961Z","caller":"traceutil/trace.go:171","msg":"trace[1277674466] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"180.352062ms","start":"2026-03-03T10:57:19.606586Z","end":"2026-03-03T10:57:19.786938Z","steps":["trace[1277674466] 'process raft request'  (duration: 180.218289ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:21.774756Z","caller":"traceutil/trace.go:171","msg":"trace[1839729866] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"172.30897ms","start":"2026-03-03T10:57:21.602423Z","end":"2026-03-03T10:57:21.774732Z","steps":["trace[1839729866] 'process raft request'  (duration: 172.145876ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:25.404849Z","caller":"traceutil/trace.go:171","msg":"trace[2141521519] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"209.604924ms","start":"2026-03-03T10:57:25.195222Z","end":"2026-03-03T10:57:25.404826Z","steps":["trace[2141521519] 'process raft request'  (duration: 209.229785ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:26.089293Z","caller":"traceutil/trace.go:171","msg":"trace[1004443435] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:538; }","duration":"488.147639ms","start":"2026-03-03T10:57:25.601119Z","end":"2026-03-03T10:57:26.089267Z","steps":["trace[1004443435] 'read index received'  (duration: 487.632427ms)","trace[1004443435] 'applied index is now lower than readState.Index'  (duration: 513.952µs)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:57:26.089446Z","caller":"traceutil/trace.go:171","msg":"trace[1534191910] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"680.859557ms","start":"2026-03-03T10:57:25.408575Z","end":"2026-03-03T10:57:26.089435Z","steps":["trace[1534191910] 'process raft request'  (duration: 680.208192ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:26.089538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:25.408551Z","time spent":"680.920119ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:515 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-03T10:57:26.089915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.781874ms","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-03-03T10:57:26.090017Z","caller":"traceutil/trace.go:171","msg":"trace[54170483] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:520; }","duration":"488.940478ms","start":"2026-03-03T10:57:25.601053Z","end":"2026-03-03T10:57:26.089994Z","steps":["trace[54170483] 'agreement among raft nodes before linearized reading'  (duration: 488.754073ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:26.090059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.17657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-03T10:57:26.090152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:25.601008Z","time spent":"489.0519ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-03T10:57:26.090165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.992776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-03T10:57:26.090182Z","caller":"traceutil/trace.go:171","msg":"trace[13099135] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:520; }","duration":"299.325114ms","start":"2026-03-03T10:57:25.790835Z","end":"2026-03-03T10:57:26.09016Z","steps":["trace[13099135] 'agreement among raft nodes before linearized reading'  (duration: 299.114009ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:26.090223Z","caller":"traceutil/trace.go:171","msg":"trace[1225522685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:520; }","duration":"294.077138ms","start":"2026-03-03T10:57:25.796131Z","end":"2026-03-03T10:57:26.090208Z","steps":["trace[1225522685] 'agreement among raft nodes before linearized reading'  (duration: 293.910004ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:26.977875Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039418802138531210,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-03T10:57:27.087978Z","caller":"traceutil/trace.go:171","msg":"trace[955916410] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:545; }","duration":"610.135913ms","start":"2026-03-03T10:57:26.47781Z","end":"2026-03-03T10:57:27.087946Z","steps":["trace[955916410] 'read index received'  (duration: 609.846316ms)","trace[955916410] 'applied index is now lower than readState.Index'  (duration: 286.547µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:57:27.088103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.270597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:57:27.088133Z","caller":"traceutil/trace.go:171","msg":"trace[1005974213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:527; }","duration":"610.347918ms","start":"2026-03-03T10:57:26.477776Z","end":"2026-03-03T10:57:27.088124Z","steps":["trace[1005974213] 'agreement among raft nodes before linearized reading'  (duration: 610.272316ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:27.088166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:26.47776Z","time spent":"610.39921ms","remote":"127.0.0.1:53378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-03T10:57:27.088194Z","caller":"traceutil/trace.go:171","msg":"trace[1087772269] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"737.74268ms","start":"2026-03-03T10:57:26.350421Z","end":"2026-03-03T10:57:27.088164Z","steps":["trace[1087772269] 'process raft request'  (duration: 737.308879ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:27.088358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:26.350392Z","time spent":"737.872283ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-bh6vd\" mod_revision:497 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-bh6vd\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-bh6vd\" > >"}
{"level":"warn","ts":"2026-03-03T10:57:29.435503Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.268772128s","expected-duration":"1s"}
{"level":"warn","ts":"2026-03-03T10:57:29.977892Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039418802138531219,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-03T10:57:30.294925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.031737ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5039418802138531220 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:522 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-03T10:57:30.295364Z","caller":"traceutil/trace.go:171","msg":"trace[1182974775] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"2.13384446s","start":"2026-03-03T10:57:28.161496Z","end":"2026-03-03T10:57:30.295341Z","steps":["trace[1182974775] 'process raft request'  (duration: 2.133761878s)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:30.295392Z","caller":"traceutil/trace.go:171","msg":"trace[432196916] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"2.133944482s","start":"2026-03-03T10:57:28.161422Z","end":"2026-03-03T10:57:30.295367Z","steps":["trace[432196916] 'process raft request'  (duration: 1.274233649s)","trace[432196916] 'compare'  (duration: 858.604497ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:57:30.295513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:28.161477Z","time spent":"2.133959973s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:523 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:57:30.295364Z","caller":"traceutil/trace.go:171","msg":"trace[300659154] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"2.13387962s","start":"2026-03-03T10:57:28.161459Z","end":"2026-03-03T10:57:30.295339Z","steps":["trace[300659154] 'process raft request'  (duration: 2.133565243s)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:30.295336Z","caller":"traceutil/trace.go:171","msg":"trace[1132351466] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:548; }","duration":"817.735557ms","start":"2026-03-03T10:57:29.477577Z","end":"2026-03-03T10:57:30.295313Z","steps":["trace[1132351466] 'read index received'  (duration: 520.935865ms)","trace[1132351466] 'applied index is now lower than readState.Index'  (duration: 296.798102ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:57:30.295571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.952952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-03T10:57:30.295581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:28.161376Z","time spent":"2.134074385s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:522 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-03T10:57:30.295625Z","caller":"traceutil/trace.go:171","msg":"trace[1808967105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:531; }","duration":"818.067835ms","start":"2026-03-03T10:57:29.477543Z","end":"2026-03-03T10:57:30.295611Z","steps":["trace[1808967105] 'agreement among raft nodes before linearized reading'  (duration: 817.932272ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:30.295654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:29.477481Z","time spent":"818.168298ms","remote":"127.0.0.1:53374","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-03-03T10:57:30.295691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:28.16145Z","time spent":"2.134157917s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:521 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-03T10:57:30.29589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.879048ms","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-03-03T10:57:30.29595Z","caller":"traceutil/trace.go:171","msg":"trace[429176411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:531; }","duration":"133.976221ms","start":"2026-03-03T10:57:30.161959Z","end":"2026-03-03T10:57:30.295935Z","steps":["trace[429176411] 'agreement among raft nodes before linearized reading'  (duration: 133.714825ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:35.723267Z","caller":"traceutil/trace.go:171","msg":"trace[923403674] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"153.435318ms","start":"2026-03-03T10:57:35.56981Z","end":"2026-03-03T10:57:35.723245Z","steps":["trace[923403674] 'process raft request'  (duration: 153.268904ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:42.74194Z","caller":"traceutil/trace.go:171","msg":"trace[261015588] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"394.214938ms","start":"2026-03-03T10:57:42.347688Z","end":"2026-03-03T10:57:42.741903Z","steps":["trace[261015588] 'read index received'  (duration: 393.831909ms)","trace[261015588] 'applied index is now lower than readState.Index'  (duration: 381.449µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:57:42.742213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.717793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:57:42.742306Z","caller":"traceutil/trace.go:171","msg":"trace[954008766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:662; }","duration":"266.869276ms","start":"2026-03-03T10:57:42.475423Z","end":"2026-03-03T10:57:42.742292Z","steps":["trace[954008766] 'agreement among raft nodes before linearized reading'  (duration: 266.726773ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:42.742319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.833391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-03T10:57:42.742323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.166841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-03T10:57:42.742375Z","caller":"traceutil/trace.go:171","msg":"trace[244076454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:662; }","duration":"318.900503ms","start":"2026-03-03T10:57:42.423462Z","end":"2026-03-03T10:57:42.742362Z","steps":["trace[244076454] 'agreement among raft nodes before linearized reading'  (duration: 318.723749ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:42.742381Z","caller":"traceutil/trace.go:171","msg":"trace[128311604] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:662; }","duration":"390.275703ms","start":"2026-03-03T10:57:42.352093Z","end":"2026-03-03T10:57:42.742369Z","steps":["trace[128311604] 'agreement among raft nodes before linearized reading'  (duration: 390.037077ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:42.74246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.605692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-fpx8k\" ","response":"range_response_count:1 size:4741"}
{"level":"info","ts":"2026-03-03T10:57:42.742483Z","caller":"traceutil/trace.go:171","msg":"trace[234340351] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-fpx8k; range_end:; response_count:1; response_revision:662; }","duration":"312.677284ms","start":"2026-03-03T10:57:42.4298Z","end":"2026-03-03T10:57:42.742477Z","steps":["trace[234340351] 'agreement among raft nodes before linearized reading'  (duration: 312.623493ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:42.742498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:42.429778Z","time spent":"312.717255ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4763,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-fpx8k\" "}
{"level":"warn","ts":"2026-03-03T10:57:42.742463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.608401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.194\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-03T10:57:42.742585Z","caller":"traceutil/trace.go:171","msg":"trace[549746522] range","detail":"{range_begin:/registry/masterleases/199.19.213.194; range_end:; response_count:1; response_revision:662; }","duration":"216.778796ms","start":"2026-03-03T10:57:42.525774Z","end":"2026-03-03T10:57:42.742553Z","steps":["trace[549746522] 'agreement among raft nodes before linearized reading'  (duration: 216.395216ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:42.742449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:42.352082Z","time spent":"390.357266ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-03T10:57:42.74258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.399686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-03T10:57:42.74241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:42.423403Z","time spent":"319.002785ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-03T10:57:42.74269Z","caller":"traceutil/trace.go:171","msg":"trace[1059174637] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:662; }","duration":"390.53605ms","start":"2026-03-03T10:57:42.352125Z","end":"2026-03-03T10:57:42.742661Z","steps":["trace[1059174637] 'agreement among raft nodes before linearized reading'  (duration: 390.0998ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:42.742748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:42.352121Z","time spent":"390.617742ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-03T10:57:42.742924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.236372ms","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-03-03T10:57:42.742955Z","caller":"traceutil/trace.go:171","msg":"trace[2023955454] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:662; }","duration":"395.324694ms","start":"2026-03-03T10:57:42.347624Z","end":"2026-03-03T10:57:42.742949Z","steps":["trace[2023955454] 'agreement among raft nodes before linearized reading'  (duration: 394.459023ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:42.742976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:42.347595Z","time spent":"395.373806ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-03T10:57:42.742956Z","caller":"traceutil/trace.go:171","msg":"trace[1830648700] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"439.737889ms","start":"2026-03-03T10:57:42.302294Z","end":"2026-03-03T10:57:42.742032Z","steps":["trace[1830648700] 'process raft request'  (duration: 439.34946ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:42.743153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:42.302268Z","time spent":"440.774144ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:645 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:57:49.22487Z","caller":"traceutil/trace.go:171","msg":"trace[1675899055] linearizableReadLoop","detail":"{readStateIndex:738; appliedIndex:737; }","duration":"456.438459ms","start":"2026-03-03T10:57:48.768413Z","end":"2026-03-03T10:57:49.224852Z","steps":["trace[1675899055] 'read index received'  (duration: 456.111001ms)","trace[1675899055] 'applied index is now lower than readState.Index'  (duration: 326.558µs)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:57:49.224936Z","caller":"traceutil/trace.go:171","msg":"trace[1798752639] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"457.765771ms","start":"2026-03-03T10:57:48.767136Z","end":"2026-03-03T10:57:49.224902Z","steps":["trace[1798752639] 'process raft request'  (duration: 457.588107ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:49.225047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.881746ms","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-03-03T10:57:49.225683Z","caller":"traceutil/trace.go:171","msg":"trace[1604092280] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:713; }","duration":"456.542111ms","start":"2026-03-03T10:57:48.76913Z","end":"2026-03-03T10:57:49.225672Z","steps":["trace[1604092280] 'agreement among raft nodes before linearized reading'  (duration: 455.828604ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:49.225721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:48.769124Z","time spent":"456.588182ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-03T10:57:49.225065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.637583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-03T10:57:49.225091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:48.767115Z","time spent":"457.891923ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:707 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:57:49.225843Z","caller":"traceutil/trace.go:171","msg":"trace[1536349980] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:713; }","duration":"457.421623ms","start":"2026-03-03T10:57:48.768386Z","end":"2026-03-03T10:57:49.225808Z","steps":["trace[1536349980] 'agreement among raft nodes before linearized reading'  (duration: 456.569392ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:49.225136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.0518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-03T10:57:49.225951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:48.768374Z","time spent":"457.544805ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-03T10:57:49.225972Z","caller":"traceutil/trace.go:171","msg":"trace[699954240] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:713; }","duration":"446.89222ms","start":"2026-03-03T10:57:48.779057Z","end":"2026-03-03T10:57:49.225949Z","steps":["trace[699954240] 'agreement among raft nodes before linearized reading'  (duration: 446.021179ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:49.226027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:48.779044Z","time spent":"446.964871ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-03T10:57:49.225292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.907457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-03T10:57:49.226098Z","caller":"traceutil/trace.go:171","msg":"trace[795606917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:713; }","duration":"446.753917ms","start":"2026-03-03T10:57:48.77933Z","end":"2026-03-03T10:57:49.226084Z","steps":["trace[795606917] 'agreement among raft nodes before linearized reading'  (duration: 445.736983ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:49.22614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:48.779318Z","time spent":"446.809558ms","remote":"127.0.0.1:53652","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-03-03T10:57:49.225443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.719248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-03T10:57:49.226224Z","caller":"traceutil/trace.go:171","msg":"trace[247846507] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:713; }","duration":"271.533327ms","start":"2026-03-03T10:57:48.95467Z","end":"2026-03-03T10:57:49.226203Z","steps":["trace[247846507] 'agreement among raft nodes before linearized reading'  (duration: 270.340359ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:49.978978Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039418802138531557,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-03T10:57:50.233031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.052666ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5039418802138531558 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:709 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-03T10:57:50.233109Z","caller":"traceutil/trace.go:171","msg":"trace[1961249589] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"1.003340277s","start":"2026-03-03T10:57:49.229754Z","end":"2026-03-03T10:57:50.233094Z","steps":["trace[1961249589] 'process raft request'  (duration: 780.157028ms)","trace[1961249589] 'compare'  (duration: 222.933833ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:57:50.233153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:49.229732Z","time spent":"1.003400008s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:709 > 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-03-03T10:57:50.385089Z","caller":"traceutil/trace.go:171","msg":"trace[1254834943] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"1.154782136s","start":"2026-03-03T10:57:49.230286Z","end":"2026-03-03T10:57:50.385069Z","steps":["trace[1254834943] 'process raft request'  (duration: 1.154700344s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:50.38522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:49.230276Z","time spent":"1.154873988s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:710 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:57:50.385372Z","caller":"traceutil/trace.go:171","msg":"trace[260424810] linearizableReadLoop","detail":"{readStateIndex:742; appliedIndex:738; }","duration":"907.446688ms","start":"2026-03-03T10:57:49.477901Z","end":"2026-03-03T10:57:50.385347Z","steps":["trace[260424810] 'read index received'  (duration: 532.076731ms)","trace[260424810] 'applied index is now lower than readState.Index'  (duration: 375.368957ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:57:50.385443Z","caller":"traceutil/trace.go:171","msg":"trace[1284195783] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"1.155318639s","start":"2026-03-03T10:57:49.23011Z","end":"2026-03-03T10:57:50.385429Z","steps":["trace[1284195783] 'process raft request'  (duration: 1.143384993s)","trace[1284195783] 'compare'  (duration: 11.377392ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:57:50.385479Z","caller":"traceutil/trace.go:171","msg":"trace[2001235353] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"1.1545127s","start":"2026-03-03T10:57:49.230925Z","end":"2026-03-03T10:57:50.385438Z","steps":["trace[2001235353] 'process raft request'  (duration: 1.15409774s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:50.385519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.613602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:57:50.385551Z","caller":"traceutil/trace.go:171","msg":"trace[386034914] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:717; }","duration":"907.674664ms","start":"2026-03-03T10:57:49.477869Z","end":"2026-03-03T10:57:50.385543Z","steps":["trace[386034914] 'agreement among raft nodes before linearized reading'  (duration: 907.608892ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:50.38557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:49.477852Z","time spent":"907.714514ms","remote":"127.0.0.1:53374","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-03-03T10:57:50.385568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:49.2301Z","time spent":"1.15538899s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:711 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-03T10:57:50.385629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:49.230907Z","time spent":"1.154642603s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:708 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-03T10:57:50.688097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.241135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:57:50.688183Z","caller":"traceutil/trace.go:171","msg":"trace[1608717049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:717; }","duration":"194.360348ms","start":"2026-03-03T10:57:50.4938Z","end":"2026-03-03T10:57:50.688161Z","steps":["trace[1608717049] 'range keys from in-memory index tree'  (duration: 194.167134ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:50.688173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.275034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:57:50.68825Z","caller":"traceutil/trace.go:171","msg":"trace[1247517628] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:717; }","duration":"171.396628ms","start":"2026-03-03T10:57:50.516835Z","end":"2026-03-03T10:57:50.688232Z","steps":["trace[1247517628] 'count revisions from in-memory index tree'  (duration: 171.181633ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:51.895633Z","caller":"traceutil/trace.go:171","msg":"trace[31769569] linearizableReadLoop","detail":"{readStateIndex:743; appliedIndex:742; }","duration":"417.068945ms","start":"2026-03-03T10:57:51.478548Z","end":"2026-03-03T10:57:51.895617Z","steps":["trace[31769569] 'read index received'  (duration: 416.899511ms)","trace[31769569] 'applied index is now lower than readState.Index'  (duration: 168.764µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:57:51.895723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.162787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:57:51.895706Z","caller":"traceutil/trace.go:171","msg":"trace[65443681] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"659.824483ms","start":"2026-03-03T10:57:51.235851Z","end":"2026-03-03T10:57:51.895675Z","steps":["trace[65443681] 'process raft request'  (duration: 659.657489ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:57:51.89575Z","caller":"traceutil/trace.go:171","msg":"trace[3121643] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:718; }","duration":"417.206138ms","start":"2026-03-03T10:57:51.478538Z","end":"2026-03-03T10:57:51.895744Z","steps":["trace[3121643] 'agreement among raft nodes before linearized reading'  (duration: 417.145266ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:51.895853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:51.478502Z","time spent":"417.344181ms","remote":"127.0.0.1:53378","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-03-03T10:57:51.895859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:57:51.235837Z","time spent":"659.941476ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:713 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-03T10:57:52.352128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.855463ms","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-03-03T10:57:52.352222Z","caller":"traceutil/trace.go:171","msg":"trace[2025152883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:718; }","duration":"115.042086ms","start":"2026-03-03T10:57:52.237157Z","end":"2026-03-03T10:57:52.352199Z","steps":["trace[2025152883] 'range keys from in-memory index tree'  (duration: 114.677938ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:52.649027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.663158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:57:52.6491Z","caller":"traceutil/trace.go:171","msg":"trace[1307785002] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:722; }","duration":"172.775991ms","start":"2026-03-03T10:57:52.476305Z","end":"2026-03-03T10:57:52.649081Z","steps":["trace[1307785002] 'range keys from in-memory index tree'  (duration: 172.586186ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:57:52.649241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.272005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.194\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-03T10:57:52.649305Z","caller":"traceutil/trace.go:171","msg":"trace[1474548868] range","detail":"{range_begin:/registry/masterleases/199.19.213.194; range_end:; response_count:1; response_revision:722; }","duration":"123.383567ms","start":"2026-03-03T10:57:52.525909Z","end":"2026-03-03T10:57:52.649292Z","steps":["trace[1474548868] 'range keys from in-memory index tree'  (duration: 123.143261ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:15.335878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.164477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-03T10:58:15.33599Z","caller":"traceutil/trace.go:171","msg":"trace[33375378] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:787; }","duration":"774.301079ms","start":"2026-03-03T10:58:14.561661Z","end":"2026-03-03T10:58:15.335962Z","steps":["trace[33375378] 'range keys from in-memory index tree'  (duration: 774.007623ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:15.335998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.738617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-03T10:58:15.336051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:14.561653Z","time spent":"774.379151ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-03T10:58:15.336056Z","caller":"traceutil/trace.go:171","msg":"trace[859668119] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:787; }","duration":"863.841019ms","start":"2026-03-03T10:58:14.472199Z","end":"2026-03-03T10:58:15.33604Z","steps":["trace[859668119] 'range keys from in-memory index tree'  (duration: 863.598034ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:15.3361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:14.472179Z","time spent":"863.908731ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-03T10:58:15.336126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.808369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-03T10:58:15.336176Z","caller":"traceutil/trace.go:171","msg":"trace[1022936534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:787; }","duration":"840.894701ms","start":"2026-03-03T10:58:14.495267Z","end":"2026-03-03T10:58:15.336162Z","steps":["trace[1022936534] 'range keys from in-memory index tree'  (duration: 840.679605ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:15.336178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.872223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-03T10:58:15.33622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:14.495247Z","time spent":"840.956662ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-03T10:58:15.33626Z","caller":"traceutil/trace.go:171","msg":"trace[596108428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:787; }","duration":"774.966726ms","start":"2026-03-03T10:58:14.561254Z","end":"2026-03-03T10:58:15.336221Z","steps":["trace[596108428] 'range keys from in-memory index tree'  (duration: 774.71432ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:15.336305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:14.561234Z","time spent":"775.057947ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-03T10:58:15.495855Z","caller":"traceutil/trace.go:171","msg":"trace[369471087] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"155.100147ms","start":"2026-03-03T10:58:15.34072Z","end":"2026-03-03T10:58:15.495821Z","steps":["trace[369471087] 'process raft request'  (duration: 154.959264ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:15.77586Z","caller":"traceutil/trace.go:171","msg":"trace[251191489] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"434.762421ms","start":"2026-03-03T10:58:15.341069Z","end":"2026-03-03T10:58:15.775831Z","steps":["trace[251191489] 'process raft request'  (duration: 434.545206ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:15.776007Z","caller":"traceutil/trace.go:171","msg":"trace[1494894948] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:818; }","duration":"300.223965ms","start":"2026-03-03T10:58:15.475751Z","end":"2026-03-03T10:58:15.775975Z","steps":["trace[1494894948] 'read index received'  (duration: 19.978417ms)","trace[1494894948] 'applied index is now lower than readState.Index'  (duration: 280.243458ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:58:15.77587Z","caller":"traceutil/trace.go:171","msg":"trace[1485959245] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"434.664909ms","start":"2026-03-03T10:58:15.34118Z","end":"2026-03-03T10:58:15.775845Z","steps":["trace[1485959245] 'process raft request'  (duration: 434.593198ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:15.776131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.361979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:58:15.776112Z","caller":"traceutil/trace.go:171","msg":"trace[778523097] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"434.894764ms","start":"2026-03-03T10:58:15.341203Z","end":"2026-03-03T10:58:15.776097Z","steps":["trace[778523097] 'process raft request'  (duration: 434.609227ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:15.776208Z","caller":"traceutil/trace.go:171","msg":"trace[489189638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:791; }","duration":"300.488123ms","start":"2026-03-03T10:58:15.475704Z","end":"2026-03-03T10:58:15.776192Z","steps":["trace[489189638] 'agreement among raft nodes before linearized reading'  (duration: 300.361409ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:15.776267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:15.341179Z","time spent":"435.051758ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:782 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-03T10:58:15.776261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:15.475683Z","time spent":"300.565984ms","remote":"127.0.0.1:53374","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-03-03T10:58:15.776273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:15.341169Z","time spent":"435.021987ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:783 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-03T10:58:15.776369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:15.341052Z","time spent":"434.950016ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:781 > 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-03-03T10:58:17.62705Z","caller":"traceutil/trace.go:171","msg":"trace[1849379258] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"124.27746ms","start":"2026-03-03T10:58:17.502756Z","end":"2026-03-03T10:58:17.627033Z","steps":["trace[1849379258] 'process raft request'  (duration: 124.183038ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:18.562368Z","caller":"traceutil/trace.go:171","msg":"trace[794030334] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"777.877483ms","start":"2026-03-03T10:58:17.784467Z","end":"2026-03-03T10:58:18.562344Z","steps":["trace[794030334] 'process raft request'  (duration: 777.762871ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:18.562506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:17.784455Z","time spent":"777.981486ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:790 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-03T10:58:18.799515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.651876ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5039418802138531792 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:789 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-03T10:58:18.80001Z","caller":"traceutil/trace.go:171","msg":"trace[502699622] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"1.015189585s","start":"2026-03-03T10:58:17.784681Z","end":"2026-03-03T10:58:18.79987Z","steps":["trace[502699622] 'process raft request'  (duration: 878.079918ms)","trace[502699622] 'compare'  (duration: 136.362779ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:58:18.800048Z","caller":"traceutil/trace.go:171","msg":"trace[1555806788] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"1.014532978s","start":"2026-03-03T10:58:17.785486Z","end":"2026-03-03T10:58:18.800019Z","steps":["trace[1555806788] 'process raft request'  (duration: 1.014218911s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:18.800199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:17.785476Z","time spent":"1.014641282s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:791 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-03T10:58:18.800238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:17.784663Z","time spent":"1.01544357s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:789 > 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-03-03T10:58:18.844879Z","caller":"traceutil/trace.go:171","msg":"trace[1293939752] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:825; }","duration":"735.518639ms","start":"2026-03-03T10:58:18.10934Z","end":"2026-03-03T10:58:18.844859Z","steps":["trace[1293939752] 'read index received'  (duration: 452.920485ms)","trace[1293939752] 'applied index is now lower than readState.Index'  (duration: 282.596754ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:58:18.845143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.799025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-03-03T10:58:18.845188Z","caller":"traceutil/trace.go:171","msg":"trace[560193452] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:797; }","duration":"735.885448ms","start":"2026-03-03T10:58:18.109292Z","end":"2026-03-03T10:58:18.845177Z","steps":["trace[560193452] 'agreement among raft nodes before linearized reading'  (duration: 735.726984ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:18.845227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:18.109272Z","time spent":"735.946769ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-03T10:58:18.845647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.013216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:58:18.845692Z","caller":"traceutil/trace.go:171","msg":"trace[1785805043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:797; }","duration":"368.059527ms","start":"2026-03-03T10:58:18.477622Z","end":"2026-03-03T10:58:18.845681Z","steps":["trace[1785805043] 'agreement among raft nodes before linearized reading'  (duration: 367.990995ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:18.845723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:18.477561Z","time spent":"368.155379ms","remote":"127.0.0.1:53374","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-03-03T10:58:18.845722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.891862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:58:18.845779Z","caller":"traceutil/trace.go:171","msg":"trace[826564357] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:797; }","duration":"190.988285ms","start":"2026-03-03T10:58:18.654776Z","end":"2026-03-03T10:58:18.845765Z","steps":["trace[826564357] 'agreement among raft nodes before linearized reading'  (duration: 190.887922ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:18.845947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.482319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-03T10:58:18.845987Z","caller":"traceutil/trace.go:171","msg":"trace[734500499] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:797; }","duration":"325.545211ms","start":"2026-03-03T10:58:18.52043Z","end":"2026-03-03T10:58:18.845975Z","steps":["trace[734500499] 'agreement among raft nodes before linearized reading'  (duration: 325.453789ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:18.846017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:18.520417Z","time spent":"325.592292ms","remote":"127.0.0.1:53714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":66,"response size":29,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "}
{"level":"info","ts":"2026-03-03T10:58:29.199957Z","caller":"traceutil/trace.go:171","msg":"trace[1699693653] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"292.351227ms","start":"2026-03-03T10:58:28.907581Z","end":"2026-03-03T10:58:29.199932Z","steps":["trace[1699693653] 'process raft request'  (duration: 292.205634ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:29.977912Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039418802138531968,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-03T10:58:30.478285Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039418802138531968,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-03T10:58:30.973655Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.773860646s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-03T10:58:30.97392Z","caller":"traceutil/trace.go:171","msg":"trace[1805913565] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"2.065964888s","start":"2026-03-03T10:58:28.907937Z","end":"2026-03-03T10:58:30.973902Z","steps":["trace[1805913565] 'process raft request'  (duration: 2.065851336s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:30.974032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:28.907916Z","time spent":"2.06605949s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:820 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:58:30.974074Z","caller":"traceutil/trace.go:171","msg":"trace[1979157288] linearizableReadLoop","detail":"{readStateIndex:915; appliedIndex:913; }","duration":"1.497097192s","start":"2026-03-03T10:58:29.47695Z","end":"2026-03-03T10:58:30.974047Z","steps":["trace[1979157288] 'read index received'  (duration: 1.496889157s)","trace[1979157288] 'applied index is now lower than readState.Index'  (duration: 206.685µs)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:58:30.974163Z","caller":"traceutil/trace.go:171","msg":"trace[810599796] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"2.059333869s","start":"2026-03-03T10:58:28.91482Z","end":"2026-03-03T10:58:30.974154Z","steps":["trace[810599796] 'process raft request'  (duration: 2.059054903s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:30.974266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:28.9148Z","time spent":"2.059393501s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:821 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-03T10:58:30.974327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.333128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:58:30.974365Z","caller":"traceutil/trace.go:171","msg":"trace[34992706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:878; }","duration":"477.394279ms","start":"2026-03-03T10:58:30.496961Z","end":"2026-03-03T10:58:30.974356Z","steps":["trace[34992706] 'agreement among raft nodes before linearized reading'  (duration: 477.325127ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:30.974388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:30.496947Z","time spent":"477.437391ms","remote":"127.0.0.1:53374","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-03-03T10:58:30.974377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.67705ms","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-03-03T10:58:30.974505Z","caller":"traceutil/trace.go:171","msg":"trace[1721098269] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:878; }","duration":"724.868574ms","start":"2026-03-03T10:58:30.249614Z","end":"2026-03-03T10:58:30.974483Z","steps":["trace[1721098269] 'agreement among raft nodes before linearized reading'  (duration: 724.67769ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:30.97451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.297778737s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-03T10:58:30.974559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:30.249589Z","time spent":"724.957907ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":29,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "}
{"level":"info","ts":"2026-03-03T10:58:30.974594Z","caller":"traceutil/trace.go:171","msg":"trace[752039303] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:878; }","duration":"1.29790313s","start":"2026-03-03T10:58:29.67667Z","end":"2026-03-03T10:58:30.974573Z","steps":["trace[752039303] 'agreement among raft nodes before linearized reading'  (duration: 1.297593333s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:30.974634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.906173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-03T10:58:30.974642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:29.67665Z","time spent":"1.297983233s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-03T10:58:30.974661Z","caller":"traceutil/trace.go:171","msg":"trace[824112602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:878; }","duration":"339.980165ms","start":"2026-03-03T10:58:30.634674Z","end":"2026-03-03T10:58:30.974654Z","steps":["trace[824112602] 'agreement among raft nodes before linearized reading'  (duration: 339.894863ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:30.974685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:30.634649Z","time spent":"340.031316ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-03T10:58:30.974761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.60722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-03T10:58:30.974785Z","caller":"traceutil/trace.go:171","msg":"trace[567425114] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:878; }","duration":"691.674001ms","start":"2026-03-03T10:58:30.283104Z","end":"2026-03-03T10:58:30.974778Z","steps":["trace[567425114] 'agreement among raft nodes before linearized reading'  (duration: 691.63443ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:30.97478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.05688403s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-03T10:58:30.974807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:30.283075Z","time spent":"691.727022ms","remote":"127.0.0.1:53430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":11,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "}
{"level":"info","ts":"2026-03-03T10:58:30.974823Z","caller":"traceutil/trace.go:171","msg":"trace[756051809] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:878; }","duration":"1.056933141s","start":"2026-03-03T10:58:29.917878Z","end":"2026-03-03T10:58:30.974811Z","steps":["trace[756051809] 'agreement among raft nodes before linearized reading'  (duration: 1.056860489s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:30.974864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:29.91782Z","time spent":"1.057036263s","remote":"127.0.0.1:53518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "}
{"level":"warn","ts":"2026-03-03T10:58:30.974554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.435842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-03T10:58:30.974974Z","caller":"traceutil/trace.go:171","msg":"trace[156406010] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:878; }","duration":"121.886583ms","start":"2026-03-03T10:58:30.853081Z","end":"2026-03-03T10:58:30.974968Z","steps":["trace[156406010] 'agreement among raft nodes before linearized reading'  (duration: 121.449982ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:30.975142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.498196228s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:58:30.975171Z","caller":"traceutil/trace.go:171","msg":"trace[1027876039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:878; }","duration":"1.498246678s","start":"2026-03-03T10:58:29.476917Z","end":"2026-03-03T10:58:30.975163Z","steps":["trace[1027876039] 'agreement among raft nodes before linearized reading'  (duration: 1.497334247s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:30.975188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:29.476902Z","time spent":"1.49828239s","remote":"127.0.0.1:53374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-03T10:58:47.48655Z","caller":"traceutil/trace.go:171","msg":"trace[846252798] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"206.030404ms","start":"2026-03-03T10:58:47.280494Z","end":"2026-03-03T10:58:47.486524Z","steps":["trace[846252798] 'process raft request'  (duration: 205.692226ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:50.716799Z","caller":"traceutil/trace.go:171","msg":"trace[132521318] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"119.095247ms","start":"2026-03-03T10:58:50.597676Z","end":"2026-03-03T10:58:50.716772Z","steps":["trace[132521318] 'process raft request'  (duration: 118.975914ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:50.71731Z","caller":"traceutil/trace.go:171","msg":"trace[1492134978] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"128.751467ms","start":"2026-03-03T10:58:50.588543Z","end":"2026-03-03T10:58:50.717295Z","steps":["trace[1492134978] 'process raft request'  (duration: 93.041454ms)","trace[1492134978] 'compare'  (duration: 34.923575ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:58:53.462829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.107936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-03-03T10:58:53.462914Z","caller":"traceutil/trace.go:171","msg":"trace[286187188] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:965; }","duration":"347.24435ms","start":"2026-03-03T10:58:53.115652Z","end":"2026-03-03T10:58:53.462896Z","steps":["trace[286187188] 'range keys from in-memory index tree'  (duration: 346.945892ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:53.46294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.080642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-03-03T10:58:53.462954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:53.115635Z","time spent":"347.309892ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-03T10:58:53.46298Z","caller":"traceutil/trace.go:171","msg":"trace[872792635] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:965; }","duration":"387.152853ms","start":"2026-03-03T10:58:53.075813Z","end":"2026-03-03T10:58:53.462966Z","steps":["trace[872792635] 'range keys from in-memory index tree'  (duration: 386.96449ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:53.462848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.746141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-03-03T10:58:53.463016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:53.075793Z","time spent":"387.215255ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-03T10:58:53.463054Z","caller":"traceutil/trace.go:171","msg":"trace[1280332961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:965; }","duration":"393.977047ms","start":"2026-03-03T10:58:53.069058Z","end":"2026-03-03T10:58:53.463035Z","steps":["trace[1280332961] 'range keys from in-memory index tree'  (duration: 393.625258ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:53.463109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:53.069046Z","time spent":"394.048018ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-03T10:58:53.463246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.379456ms","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-03-03T10:58:53.463292Z","caller":"traceutil/trace.go:171","msg":"trace[1829592292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:965; }","duration":"399.458138ms","start":"2026-03-03T10:58:53.063822Z","end":"2026-03-03T10:58:53.463281Z","steps":["trace[1829592292] 'range keys from in-memory index tree'  (duration: 398.72526ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:53.463331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:53.063802Z","time spent":"399.520939ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-03T10:58:54.040464Z","caller":"traceutil/trace.go:171","msg":"trace[1066421447] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"573.003386ms","start":"2026-03-03T10:58:53.467435Z","end":"2026-03-03T10:58:54.040438Z","steps":["trace[1066421447] 'process raft request'  (duration: 572.819991ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:54.040613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:53.467416Z","time spent":"573.130608ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:953 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:58:54.040689Z","caller":"traceutil/trace.go:171","msg":"trace[1262929547] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1008; }","duration":"564.962553ms","start":"2026-03-03T10:58:53.475706Z","end":"2026-03-03T10:58:54.040669Z","steps":["trace[1262929547] 'read index received'  (duration: 74.242104ms)","trace[1262929547] 'applied index is now lower than readState.Index'  (duration: 490.719769ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:58:54.040786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.068335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:58:54.040774Z","caller":"traceutil/trace.go:171","msg":"trace[681452270] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"572.809001ms","start":"2026-03-03T10:58:53.46794Z","end":"2026-03-03T10:58:54.040749Z","steps":["trace[681452270] 'process raft request'  (duration: 572.654237ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:54.040818Z","caller":"traceutil/trace.go:171","msg":"trace[402610283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:969; }","duration":"565.155557ms","start":"2026-03-03T10:58:53.475653Z","end":"2026-03-03T10:58:54.040809Z","steps":["trace[402610283] 'agreement among raft nodes before linearized reading'  (duration: 565.096526ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:54.040843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:53.475646Z","time spent":"565.193229ms","remote":"127.0.0.1:53374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-03T10:58:54.040818Z","caller":"traceutil/trace.go:171","msg":"trace[1057108875] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"573.328434ms","start":"2026-03-03T10:58:53.46745Z","end":"2026-03-03T10:58:54.040779Z","steps":["trace[1057108875] 'process raft request'  (duration: 572.934084ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:54.040937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:53.467922Z","time spent":"572.915483ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:954 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-03T10:58:54.041007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:53.467435Z","time spent":"573.467327ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:956 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:58:54.075759Z","caller":"traceutil/trace.go:171","msg":"trace[128614614] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"196.186609ms","start":"2026-03-03T10:58:53.879546Z","end":"2026-03-03T10:58:54.075732Z","steps":["trace[128614614] 'process raft request'  (duration: 195.953063ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:54.075772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.298335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-03T10:58:54.075844Z","caller":"traceutil/trace.go:171","msg":"trace[1892260616] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:970; }","duration":"120.424928ms","start":"2026-03-03T10:58:53.955402Z","end":"2026-03-03T10:58:54.075827Z","steps":["trace[1892260616] 'agreement among raft nodes before linearized reading'  (duration: 120.288345ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:54.075863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.005965ms","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-03-03T10:58:54.075952Z","caller":"traceutil/trace.go:171","msg":"trace[1993284088] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:970; }","duration":"568.135019ms","start":"2026-03-03T10:58:53.507789Z","end":"2026-03-03T10:58:54.075924Z","steps":["trace[1993284088] 'agreement among raft nodes before linearized reading'  (duration: 567.904213ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:54.076021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:53.507768Z","time spent":"568.238592ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-03T10:58:55.046527Z","caller":"traceutil/trace.go:171","msg":"trace[1677376002] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1013; }","duration":"162.829642ms","start":"2026-03-03T10:58:54.883674Z","end":"2026-03-03T10:58:55.046504Z","steps":["trace[1677376002] 'read index received'  (duration: 162.627787ms)","trace[1677376002] 'applied index is now lower than readState.Index'  (duration: 200.955µs)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:58:55.046587Z","caller":"traceutil/trace.go:171","msg":"trace[127212963] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"175.30082ms","start":"2026-03-03T10:58:54.871248Z","end":"2026-03-03T10:58:55.046549Z","steps":["trace[127212963] 'process raft request'  (duration: 175.105776ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:55.046671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.978815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:58:55.046711Z","caller":"traceutil/trace.go:171","msg":"trace[1493166528] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:972; }","duration":"163.072428ms","start":"2026-03-03T10:58:54.883626Z","end":"2026-03-03T10:58:55.046699Z","steps":["trace[1493166528] 'agreement among raft nodes before linearized reading'  (duration: 162.969525ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:55.862275Z","caller":"traceutil/trace.go:171","msg":"trace[925950705] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"304.748464ms","start":"2026-03-03T10:58:55.557502Z","end":"2026-03-03T10:58:55.86225Z","steps":["trace[925950705] 'process raft request'  (duration: 304.58292ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:55.862518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:55.557476Z","time spent":"304.954779ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:966 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-03T10:58:57.090018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.157879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-03-03T10:58:57.090098Z","caller":"traceutil/trace.go:171","msg":"trace[1009032513] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:973; }","duration":"714.289482ms","start":"2026-03-03T10:58:56.375788Z","end":"2026-03-03T10:58:57.090078Z","steps":["trace[1009032513] 'range keys from in-memory index tree'  (duration: 713.976945ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:57.090138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:56.375768Z","time spent":"714.360854ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-03T10:58:57.090215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.04430782s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-03T10:58:57.09026Z","caller":"traceutil/trace.go:171","msg":"trace[2043889028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:973; }","duration":"1.044404222s","start":"2026-03-03T10:58:56.045843Z","end":"2026-03-03T10:58:57.090248Z","steps":["trace[2043889028] 'range keys from in-memory index tree'  (duration: 1.044145227s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:57.090296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:56.045827Z","time spent":"1.044456714s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-03T10:58:57.090355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.76606ms","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-03-03T10:58:57.090425Z","caller":"traceutil/trace.go:171","msg":"trace[1938245249] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:973; }","duration":"977.870642ms","start":"2026-03-03T10:58:56.112536Z","end":"2026-03-03T10:58:57.090406Z","steps":["trace[1938245249] 'range keys from in-memory index tree'  (duration: 977.556825ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:57.090464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:56.112522Z","time spent":"977.933344ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-03T10:58:57.090469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044561496s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"warn","ts":"2026-03-03T10:58:57.090544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044464324s","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-03-03T10:58:57.090577Z","caller":"traceutil/trace.go:171","msg":"trace[1688822959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:973; }","duration":"1.044534206s","start":"2026-03-03T10:58:56.046033Z","end":"2026-03-03T10:58:57.090567Z","steps":["trace[1688822959] 'range keys from in-memory index tree'  (duration: 1.044342331s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:57.090604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:56.046011Z","time spent":"1.044586286s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-03T10:58:57.090564Z","caller":"traceutil/trace.go:171","msg":"trace[1376337780] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:973; }","duration":"1.044681119s","start":"2026-03-03T10:58:56.045852Z","end":"2026-03-03T10:58:57.090534Z","steps":["trace[1376337780] 'range keys from in-memory index tree'  (duration: 1.044425083s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:57.090669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:56.045827Z","time spent":"1.044812482s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-03T10:58:57.465281Z","caller":"traceutil/trace.go:171","msg":"trace[1492964021] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"784.271146ms","start":"2026-03-03T10:58:56.680985Z","end":"2026-03-03T10:58:57.465256Z","steps":["trace[1492964021] 'process raft request'  (duration: 784.03497ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:57.465671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:56.68096Z","time spent":"784.420618ms","remote":"127.0.0.1:53558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5958,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:947 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5924 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-03T10:58:57.612523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.203298ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:58:57.612649Z","caller":"traceutil/trace.go:171","msg":"trace[1506280968] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:974; }","duration":"106.352332ms","start":"2026-03-03T10:58:57.506279Z","end":"2026-03-03T10:58:57.612631Z","steps":["trace[1506280968] 'range keys from in-memory index tree'  (duration: 106.183328ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:57.674723Z","caller":"traceutil/trace.go:171","msg":"trace[1821844430] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"580.624507ms","start":"2026-03-03T10:58:57.094083Z","end":"2026-03-03T10:58:57.674707Z","steps":["trace[1821844430] 'process raft request'  (duration: 580.449283ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:57.674843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:57.094061Z","time spent":"580.71862ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:967 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:58:57.674976Z","caller":"traceutil/trace.go:171","msg":"trace[174293960] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"580.583387ms","start":"2026-03-03T10:58:57.094377Z","end":"2026-03-03T10:58:57.674961Z","steps":["trace[174293960] 'process raft request'  (duration: 580.29394ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:57.675065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:57.094357Z","time spent":"580.663449ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:971 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-03T10:58:57.675217Z","caller":"traceutil/trace.go:171","msg":"trace[560711535] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"580.764161ms","start":"2026-03-03T10:58:57.09444Z","end":"2026-03-03T10:58:57.675204Z","steps":["trace[560711535] 'process raft request'  (duration: 580.426803ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:57.675302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:57.094429Z","time spent":"580.836683ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:969 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:58:57.67531Z","caller":"traceutil/trace.go:171","msg":"trace[1933229895] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"580.438804ms","start":"2026-03-03T10:58:57.09486Z","end":"2026-03-03T10:58:57.675299Z","steps":["trace[1933229895] 'process raft request'  (duration: 580.345561ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:57.675301Z","caller":"traceutil/trace.go:171","msg":"trace[949076936] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1016; }","duration":"182.00757ms","start":"2026-03-03T10:58:57.493269Z","end":"2026-03-03T10:58:57.675277Z","steps":["trace[949076936] 'read index received'  (duration: 181.17869ms)","trace[949076936] 'applied index is now lower than readState.Index'  (duration: 828.31µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:58:57.675373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:57.094853Z","time spent":"580.488045ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:963 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-03T10:58:57.67545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.162734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:58:57.675463Z","caller":"traceutil/trace.go:171","msg":"trace[1482971027] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"580.964966ms","start":"2026-03-03T10:58:57.094487Z","end":"2026-03-03T10:58:57.675452Z","steps":["trace[1482971027] 'process raft request'  (duration: 580.640269ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:57.675489Z","caller":"traceutil/trace.go:171","msg":"trace[359247482] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:980; }","duration":"182.248596ms","start":"2026-03-03T10:58:57.49323Z","end":"2026-03-03T10:58:57.675479Z","steps":["trace[359247482] 'agreement among raft nodes before linearized reading'  (duration: 182.143883ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:57.675476Z","caller":"traceutil/trace.go:171","msg":"trace[1700495254] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"544.974565ms","start":"2026-03-03T10:58:57.130472Z","end":"2026-03-03T10:58:57.675446Z","steps":["trace[1700495254] 'process raft request'  (duration: 544.76582ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:57.675519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:57.09448Z","time spent":"581.008537ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:968 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-03T10:58:57.675659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:57.130457Z","time spent":"545.108059ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:922 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-03T10:58:58.099044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.699225ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5039418802138532224 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-gl9qx.18994fae2ce8d915\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-gl9qx.18994fae2ce8d915\" value_size:675 lease:5039418802138531918 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-03T10:58:58.099437Z","caller":"traceutil/trace.go:171","msg":"trace[1787254234] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"252.925955ms","start":"2026-03-03T10:58:57.846467Z","end":"2026-03-03T10:58:58.099393Z","steps":["trace[1787254234] 'process raft request'  (duration: 113.79037ms)","trace[1787254234] 'compare'  (duration: 138.464639ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:58:58.099662Z","caller":"traceutil/trace.go:171","msg":"trace[160378515] linearizableReadLoop","detail":"{readStateIndex:1023; appliedIndex:1022; }","duration":"233.644784ms","start":"2026-03-03T10:58:57.865991Z","end":"2026-03-03T10:58:58.099636Z","steps":["trace[160378515] 'read index received'  (duration: 94.278853ms)","trace[160378515] 'applied index is now lower than readState.Index'  (duration: 139.363281ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:58:58.39769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.666217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-03T10:58:58.397779Z","caller":"traceutil/trace.go:171","msg":"trace[538307827] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:981; }","duration":"531.799ms","start":"2026-03-03T10:58:57.865959Z","end":"2026-03-03T10:58:58.397758Z","steps":["trace[538307827] 'agreement among raft nodes before linearized reading'  (duration: 233.811438ms)","trace[538307827] 'range keys from in-memory index tree'  (duration: 297.754367ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:58:58.397825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:57.86594Z","time spent":"531.875963ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-03T10:58:58.39781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.632748ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5039418802138532225 > lease_revoke:<id:45ef9cb357e448df>","response":"size:27"}
{"level":"info","ts":"2026-03-03T10:58:58.397945Z","caller":"traceutil/trace.go:171","msg":"trace[1807624112] linearizableReadLoop","detail":"{readStateIndex:1024; appliedIndex:1023; }","duration":"298.055614ms","start":"2026-03-03T10:58:58.099856Z","end":"2026-03-03T10:58:58.397912Z","steps":["trace[1807624112] 'read index received'  (duration: 58.511µs)","trace[1807624112] 'applied index is now lower than readState.Index'  (duration: 297.995093ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:58:58.398055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.441241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:58:58.398097Z","caller":"traceutil/trace.go:171","msg":"trace[1895292189] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:981; }","duration":"482.520763ms","start":"2026-03-03T10:58:57.91556Z","end":"2026-03-03T10:58:58.398081Z","steps":["trace[1895292189] 'agreement among raft nodes before linearized reading'  (duration: 482.425131ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:58.398145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:57.915542Z","time spent":"482.590814ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-03-03T10:58:58.581502Z","caller":"traceutil/trace.go:171","msg":"trace[534345575] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"401.917677ms","start":"2026-03-03T10:58:58.179565Z","end":"2026-03-03T10:58:58.581482Z","steps":["trace[534345575] 'process raft request'  (duration: 401.780953ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:58.581618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:58.179547Z","time spent":"402.019109ms","remote":"127.0.0.1:53460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":779,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-gl9qx.18994fae40bf5faf\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-gl9qx.18994fae40bf5faf\" value_size:675 lease:5039418802138531918 >> failure:<>"}
{"level":"warn","ts":"2026-03-03T10:58:59.447566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.345675ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5039418802138532229 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:973 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-03T10:58:59.447855Z","caller":"traceutil/trace.go:171","msg":"trace[715585562] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"1.045427645s","start":"2026-03-03T10:58:58.402394Z","end":"2026-03-03T10:58:59.447822Z","steps":["trace[715585562] 'process raft request'  (duration: 291.669862ms)","trace[715585562] 'compare'  (duration: 753.060727ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:58:59.447936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044905223s","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:5"}
{"level":"info","ts":"2026-03-03T10:58:59.447958Z","caller":"traceutil/trace.go:171","msg":"trace[1513229972] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:983; }","duration":"1.044954573s","start":"2026-03-03T10:58:58.402997Z","end":"2026-03-03T10:58:59.447952Z","steps":["trace[1513229972] 'agreement among raft nodes before linearized reading'  (duration: 1.044915822s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:59.447978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:58.402981Z","time spent":"1.044991525s","remote":"127.0.0.1:53472","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":"info","ts":"2026-03-03T10:58:59.447893Z","caller":"traceutil/trace.go:171","msg":"trace[787201699] linearizableReadLoop","detail":"{readStateIndex:1026; appliedIndex:1024; }","duration":"1.044851382s","start":"2026-03-03T10:58:58.40303Z","end":"2026-03-03T10:58:59.447881Z","steps":["trace[787201699] 'read index received'  (duration: 178.390754ms)","trace[787201699] 'applied index is now lower than readState.Index'  (duration: 866.459728ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:58:59.448111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:58.402371Z","time spent":"1.04564519s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:973 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-03T10:58:59.448156Z","caller":"traceutil/trace.go:171","msg":"trace[1030226304] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"862.844301ms","start":"2026-03-03T10:58:58.5853Z","end":"2026-03-03T10:58:59.448145Z","steps":["trace[1030226304] 'process raft request'  (duration: 862.533144ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:59.448259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:58.585275Z","time spent":"862.937073ms","remote":"127.0.0.1:53460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":842,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-gl9qx.18994fae40d0577f\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-gl9qx.18994fae40d0577f\" value_size:738 lease:5039418802138531918 >> failure:<>"}
{"level":"warn","ts":"2026-03-03T10:58:59.976641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.253324ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5039418802138532232 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-03T10:58:59.976739Z","caller":"traceutil/trace.go:171","msg":"trace[526674340] linearizableReadLoop","detail":"{readStateIndex:1028; appliedIndex:1027; }","duration":"498.933509ms","start":"2026-03-03T10:58:59.477787Z","end":"2026-03-03T10:58:59.97672Z","steps":["trace[526674340] 'read index received'  (duration: 272.49831ms)","trace[526674340] 'applied index is now lower than readState.Index'  (duration: 226.433699ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:58:59.976972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.392285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"warn","ts":"2026-03-03T10:58:59.976976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.44675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:58:59.977003Z","caller":"traceutil/trace.go:171","msg":"trace[1404495591] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:985; }","duration":"295.458167ms","start":"2026-03-03T10:58:59.681538Z","end":"2026-03-03T10:58:59.976996Z","steps":["trace[1404495591] 'agreement among raft nodes before linearized reading'  (duration: 295.328194ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:58:59.97716Z","caller":"traceutil/trace.go:171","msg":"trace[313687653] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"527.699347ms","start":"2026-03-03T10:58:59.449451Z","end":"2026-03-03T10:58:59.977151Z","steps":["trace[313687653] 'process raft request'  (duration: 300.88647ms)","trace[313687653] 'compare'  (duration: 225.939317ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:58:59.977204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:59.449438Z","time spent":"527.747838ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<>"}
{"level":"info","ts":"2026-03-03T10:58:59.9771Z","caller":"traceutil/trace.go:171","msg":"trace[308489289] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:985; }","duration":"453.546752ms","start":"2026-03-03T10:58:59.523468Z","end":"2026-03-03T10:58:59.977015Z","steps":["trace[308489289] 'agreement among raft nodes before linearized reading'  (duration: 453.396089ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:59.977316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.277685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-03T10:58:59.977343Z","caller":"traceutil/trace.go:171","msg":"trace[770398829] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:985; }","duration":"296.339757ms","start":"2026-03-03T10:58:59.680996Z","end":"2026-03-03T10:58:59.977336Z","steps":["trace[770398829] 'agreement among raft nodes before linearized reading'  (duration: 296.262145ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:59.977319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.529183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:58:59.977436Z","caller":"traceutil/trace.go:171","msg":"trace[739231015] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:985; }","duration":"499.774139ms","start":"2026-03-03T10:58:59.477647Z","end":"2026-03-03T10:58:59.977421Z","steps":["trace[739231015] 'agreement among raft nodes before linearized reading'  (duration: 499.600025ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:59.97751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.77893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-03T10:58:59.9775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:59.523448Z","time spent":"453.827278ms","remote":"127.0.0.1:42888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"info","ts":"2026-03-03T10:58:59.977538Z","caller":"traceutil/trace.go:171","msg":"trace[1447034629] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:985; }","duration":"297.843101ms","start":"2026-03-03T10:58:59.679688Z","end":"2026-03-03T10:58:59.977531Z","steps":["trace[1447034629] 'agreement among raft nodes before linearized reading'  (duration: 297.78747ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:58:59.977518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:59.477626Z","time spent":"499.884991ms","remote":"127.0.0.1:53374","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-03-03T10:58:59.977452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.279225ms","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-03-03T10:58:59.97765Z","caller":"traceutil/trace.go:171","msg":"trace[2026088262] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:985; }","duration":"296.495601ms","start":"2026-03-03T10:58:59.681144Z","end":"2026-03-03T10:58:59.97764Z","steps":["trace[2026088262] 'agreement among raft nodes before linearized reading'  (duration: 296.266936ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:00.474817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.01088ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5039418802138532236 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:978 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-03T10:59:00.474891Z","caller":"traceutil/trace.go:171","msg":"trace[150822778] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"493.190119ms","start":"2026-03-03T10:58:59.981688Z","end":"2026-03-03T10:59:00.474879Z","steps":["trace[150822778] 'process raft request'  (duration: 127.070206ms)","trace[150822778] 'compare'  (duration: 365.884827ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:59:00.474929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:59.981677Z","time spent":"493.234189ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:978 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:59:00.505685Z","caller":"traceutil/trace.go:171","msg":"trace[1408791191] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"522.13227ms","start":"2026-03-03T10:58:59.983542Z","end":"2026-03-03T10:59:00.505674Z","steps":["trace[1408791191] 'process raft request'  (duration: 522.002187ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:00.505785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:59.983532Z","time spent":"522.190622ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:977 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:59:00.505841Z","caller":"traceutil/trace.go:171","msg":"trace[1402061806] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1028; }","duration":"523.316247ms","start":"2026-03-03T10:58:59.982509Z","end":"2026-03-03T10:59:00.505825Z","steps":["trace[1402061806] 'read index received'  (duration: 126.230607ms)","trace[1402061806] 'applied index is now lower than readState.Index'  (duration: 397.08492ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:59:00.505942Z","caller":"traceutil/trace.go:171","msg":"trace[211776529] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"522.075549ms","start":"2026-03-03T10:58:59.983857Z","end":"2026-03-03T10:59:00.505932Z","steps":["trace[211776529] 'process raft request'  (duration: 521.898475ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:59:00.505927Z","caller":"traceutil/trace.go:171","msg":"trace[1699087876] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"522.067739ms","start":"2026-03-03T10:58:59.983837Z","end":"2026-03-03T10:59:00.505905Z","steps":["trace[1699087876] 'process raft request'  (duration: 521.811663ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:00.506127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:59.983826Z","time spent":"522.227252ms","remote":"127.0.0.1:53460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":868,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/external-resizer-rbd-csi-ceph-com.18994faeac54c040\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/external-resizer-rbd-csi-ceph-com.18994faeac54c040\" value_size:771 lease:5039418802138531918 >> failure:<>"}
{"level":"warn","ts":"2026-03-03T10:59:00.506135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.621984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-03-03T10:59:00.506193Z","caller":"traceutil/trace.go:171","msg":"trace[821956903] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:990; }","duration":"523.698476ms","start":"2026-03-03T10:58:59.982482Z","end":"2026-03-03T10:59:00.50618Z","steps":["trace[821956903] 'agreement among raft nodes before linearized reading'  (duration: 523.570213ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:00.506223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:59.982471Z","time spent":"523.745657ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-03T10:59:00.506013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:59.983842Z","time spent":"522.12943ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:975 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:59:00.505628Z","caller":"traceutil/trace.go:171","msg":"trace[1987703880] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"523.518062ms","start":"2026-03-03T10:58:59.98207Z","end":"2026-03-03T10:59:00.505589Z","steps":["trace[1987703880] 'process raft request'  (duration: 523.353448ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:00.507141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:58:59.982026Z","time spent":"525.047207ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:976 > 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-03-03T10:59:00.87372Z","caller":"traceutil/trace.go:171","msg":"trace[1076170668] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1033; }","duration":"168.479683ms","start":"2026-03-03T10:59:00.70522Z","end":"2026-03-03T10:59:00.8737Z","steps":["trace[1076170668] 'read index received'  (duration: 161.735729ms)","trace[1076170668] 'applied index is now lower than readState.Index'  (duration: 6.743174ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:59:00.873756Z","caller":"traceutil/trace.go:171","msg":"trace[870119155] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"364.131387ms","start":"2026-03-03T10:59:00.509604Z","end":"2026-03-03T10:59:00.873736Z","steps":["trace[870119155] 'process raft request'  (duration: 357.409913ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:00.874243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:00.509589Z","time spent":"364.218679ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:985 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-03T10:59:00.874544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.283531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-03T10:59:00.874628Z","caller":"traceutil/trace.go:171","msg":"trace[240994063] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:991; }","duration":"169.419495ms","start":"2026-03-03T10:59:00.705188Z","end":"2026-03-03T10:59:00.874607Z","steps":["trace[240994063] 'agreement among raft nodes before linearized reading'  (duration: 168.571535ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:59:02.629412Z","caller":"traceutil/trace.go:171","msg":"trace[1402960316] linearizableReadLoop","detail":"{readStateIndex:1043; appliedIndex:1042; }","duration":"119.015772ms","start":"2026-03-03T10:59:02.510345Z","end":"2026-03-03T10:59:02.629361Z","steps":["trace[1402960316] 'read index received'  (duration: 118.844238ms)","trace[1402960316] 'applied index is now lower than readState.Index'  (duration: 170.334µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:59:02.629692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.252797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-03T10:59:02.629739Z","caller":"traceutil/trace.go:171","msg":"trace[561202974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1000; }","duration":"119.353959ms","start":"2026-03-03T10:59:02.510371Z","end":"2026-03-03T10:59:02.629725Z","steps":["trace[561202974] 'agreement among raft nodes before linearized reading'  (duration: 119.158085ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:59:02.629521Z","caller":"traceutil/trace.go:171","msg":"trace[1639960847] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"123.965305ms","start":"2026-03-03T10:59:02.505517Z","end":"2026-03-03T10:59:02.629482Z","steps":["trace[1639960847] 'process raft request'  (duration: 123.696088ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:03.34078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.281566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-03T10:59:03.340897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.501721ms","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-03-03T10:59:03.340959Z","caller":"traceutil/trace.go:171","msg":"trace[1612539903] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1000; }","duration":"830.428399ms","start":"2026-03-03T10:59:02.51045Z","end":"2026-03-03T10:59:03.340878Z","steps":["trace[1612539903] 'agreement among raft nodes before linearized reading'  (duration: 119.117634ms)","trace[1612539903] 'range keys from in-memory index tree'  (duration: 711.000388ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:59:03.341019Z","caller":"traceutil/trace.go:171","msg":"trace[2063248657] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1000; }","duration":"830.707116ms","start":"2026-03-03T10:59:02.510286Z","end":"2026-03-03T10:59:03.340993Z","steps":["trace[2063248657] 'agreement among raft nodes before linearized reading'  (duration: 119.314268ms)","trace[2063248657] 'range keys from in-memory index tree'  (duration: 711.128741ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:59:03.341022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:02.510442Z","time spent":"830.565583ms","remote":"127.0.0.1:53652","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-03-03T10:59:03.341075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:02.510262Z","time spent":"830.797868ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-03T10:59:03.341109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.796691ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5039418802138532264 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:45ef9cb357e449a7>","response":"size:39"}
{"level":"warn","ts":"2026-03-03T10:59:03.34121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:02.63113Z","time spent":"710.076617ms","remote":"127.0.0.1:53416","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-03T10:59:03.839692Z","caller":"traceutil/trace.go:171","msg":"trace[304330372] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1043; }","duration":"1.157817986s","start":"2026-03-03T10:59:02.681807Z","end":"2026-03-03T10:59:03.839625Z","steps":["trace[304330372] 'read index received'  (duration: 315.640238ms)","trace[304330372] 'applied index is now lower than readState.Index'  (duration: 842.176838ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:59:03.839694Z","caller":"traceutil/trace.go:171","msg":"trace[1309013180] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"1.204460593s","start":"2026-03-03T10:59:02.635202Z","end":"2026-03-03T10:59:03.839662Z","steps":["trace[1309013180] 'process raft request'  (duration: 1.204089565s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:03.839888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.158073581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-03-03T10:59:03.840108Z","caller":"traceutil/trace.go:171","msg":"trace[127113235] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1001; }","duration":"1.158369419s","start":"2026-03-03T10:59:02.681725Z","end":"2026-03-03T10:59:03.840095Z","steps":["trace[127113235] 'agreement among raft nodes before linearized reading'  (duration: 1.158018821s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:03.840155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:02.681683Z","time spent":"1.158457291s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-03T10:59:03.84023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.343496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-03T10:59:03.840285Z","caller":"traceutil/trace.go:171","msg":"trace[284494323] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"494.317374ms","start":"2026-03-03T10:59:03.345926Z","end":"2026-03-03T10:59:03.840243Z","steps":["trace[284494323] 'process raft request'  (duration: 494.100919ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:59:03.840315Z","caller":"traceutil/trace.go:171","msg":"trace[1868684978] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"497.094477ms","start":"2026-03-03T10:59:03.343178Z","end":"2026-03-03T10:59:03.840273Z","steps":["trace[1868684978] 'process raft request'  (duration: 496.739539ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:59:03.84035Z","caller":"traceutil/trace.go:171","msg":"trace[977692634] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"493.461394ms","start":"2026-03-03T10:59:03.34688Z","end":"2026-03-03T10:59:03.840341Z","steps":["trace[977692634] 'process raft request'  (duration: 493.188098ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:03.840361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:03.34591Z","time spent":"494.402766ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:987 > 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-03-03T10:59:03.840378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:03.343146Z","time spent":"497.193809ms","remote":"127.0.0.1:53416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.19.213.194\" mod_revision:965 > success:<request_put:<key:\"/registry/masterleases/199.19.213.194\" value_size:67 lease:5039418802138532263 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.194\" > >"}
{"level":"warn","ts":"2026-03-03T10:59:03.840443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:03.346862Z","time spent":"493.518765ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:990 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-03T10:59:03.840485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.603462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T10:59:03.840308Z","caller":"traceutil/trace.go:171","msg":"trace[1532982076] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1004; }","duration":"376.464079ms","start":"2026-03-03T10:59:03.463826Z","end":"2026-03-03T10:59:03.840291Z","steps":["trace[1532982076] 'agreement among raft nodes before linearized reading'  (duration: 376.278705ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T10:59:03.840595Z","caller":"traceutil/trace.go:171","msg":"trace[104513903] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1004; }","duration":"362.723895ms","start":"2026-03-03T10:59:03.477824Z","end":"2026-03-03T10:59:03.840548Z","steps":["trace[104513903] 'agreement among raft nodes before linearized reading'  (duration: 362.580882ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:03.840623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:03.463805Z","time spent":"376.785386ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-03T10:59:03.840702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:03.47781Z","time spent":"362.881268ms","remote":"127.0.0.1:53374","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-03-03T10:59:03.840819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:02.635184Z","time spent":"1.204841611s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:988 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-03T10:59:48.195839Z","caller":"traceutil/trace.go:171","msg":"trace[289503292] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1251; }","duration":"405.227246ms","start":"2026-03-03T10:59:47.790577Z","end":"2026-03-03T10:59:48.195804Z","steps":["trace[289503292] 'read index received'  (duration: 405.088773ms)","trace[289503292] 'applied index is now lower than readState.Index'  (duration: 136.713µs)"],"step_count":2}
{"level":"info","ts":"2026-03-03T10:59:48.195908Z","caller":"traceutil/trace.go:171","msg":"trace[1638257236] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"407.816176ms","start":"2026-03-03T10:59:47.788058Z","end":"2026-03-03T10:59:48.195874Z","steps":["trace[1638257236] 'process raft request'  (duration: 407.55025ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:48.196267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:47.788028Z","time spent":"407.96622ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1192 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >"}
{"level":"warn","ts":"2026-03-03T10:59:48.196339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.437991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-03T10:59:48.196404Z","caller":"traceutil/trace.go:171","msg":"trace[766221806] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1200; }","duration":"405.855711ms","start":"2026-03-03T10:59:47.79053Z","end":"2026-03-03T10:59:48.196385Z","steps":["trace[766221806] 'agreement among raft nodes before linearized reading'  (duration: 405.443131ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:48.196473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T10:59:47.79051Z","time spent":"405.940613ms","remote":"127.0.0.1:53558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":29,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "}
{"level":"info","ts":"2026-03-03T10:59:48.304599Z","caller":"traceutil/trace.go:171","msg":"trace[1709350500] linearizableReadLoop","detail":"{readStateIndex:1253; appliedIndex:1252; }","duration":"108.631215ms","start":"2026-03-03T10:59:48.195938Z","end":"2026-03-03T10:59:48.304569Z","steps":["trace[1709350500] 'read index received'  (duration: 105.80279ms)","trace[1709350500] 'applied index is now lower than readState.Index'  (duration: 2.826505ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T10:59:48.304853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.19506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-03T10:59:48.304941Z","caller":"traceutil/trace.go:171","msg":"trace[855144916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1200; }","duration":"225.360464ms","start":"2026-03-03T10:59:48.079559Z","end":"2026-03-03T10:59:48.304919Z","steps":["trace[855144916] 'agreement among raft nodes before linearized reading'  (duration: 225.045576ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:48.305051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.161948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-03T10:59:48.305132Z","caller":"traceutil/trace.go:171","msg":"trace[298988583] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1200; }","duration":"228.323161ms","start":"2026-03-03T10:59:48.076794Z","end":"2026-03-03T10:59:48.305117Z","steps":["trace[298988583] 'agreement among raft nodes before linearized reading'  (duration: 227.943532ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:48.305305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.682384ms","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-03-03T10:59:48.305349Z","caller":"traceutil/trace.go:171","msg":"trace[1948246274] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1200; }","duration":"226.749425ms","start":"2026-03-03T10:59:48.078589Z","end":"2026-03-03T10:59:48.305338Z","steps":["trace[1948246274] 'agreement among raft nodes before linearized reading'  (duration: 226.047289ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T10:59:48.305516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.355513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-03T10:59:48.305617Z","caller":"traceutil/trace.go:171","msg":"trace[145305873] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1200; }","duration":"232.470146ms","start":"2026-03-03T10:59:48.073071Z","end":"2026-03-03T10:59:48.305541Z","steps":["trace[145305873] 'agreement among raft nodes before linearized reading'  (duration: 231.728159ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T11:01:06.86319Z","caller":"traceutil/trace.go:171","msg":"trace[1519006575] transaction","detail":"{read_only:false; response_revision:1521; number_of_response:1; }","duration":"129.038106ms","start":"2026-03-03T11:01:06.734132Z","end":"2026-03-03T11:01:06.86317Z","steps":["trace[1519006575] 'process raft request'  (duration: 128.691328ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T11:02:05.314748Z","caller":"traceutil/trace.go:171","msg":"trace[2049410714] transaction","detail":"{read_only:false; response_revision:1778; number_of_response:1; }","duration":"348.075437ms","start":"2026-03-03T11:02:04.966649Z","end":"2026-03-03T11:02:05.314724Z","steps":["trace[2049410714] 'process raft request'  (duration: 347.945974ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:05.315094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:04.966623Z","time spent":"348.401675ms","remote":"127.0.0.1:53460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":720,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/default/test-pvc-pod.18994fd9be235389\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/test-pvc-pod.18994fd9be235389\" value_size:648 lease:5039418802138534154 >> failure:<>"}
{"level":"warn","ts":"2026-03-03T11:02:06.071393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.571745ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5039418802138534238 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:1122 > success:<request_put:<key:\"/registry/minions/instance\" value_size:6829 >> failure:<request_range:<key:\"/registry/minions/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-03T11:02:06.071516Z","caller":"traceutil/trace.go:171","msg":"trace[596862914] linearizableReadLoop","detail":"{readStateIndex:1860; appliedIndex:1858; }","duration":"879.909235ms","start":"2026-03-03T11:02:05.191588Z","end":"2026-03-03T11:02:06.071497Z","steps":["trace[596862914] 'read index received'  (duration: 123.020026ms)","trace[596862914] 'applied index is now lower than readState.Index'  (duration: 756.887979ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T11:02:06.07156Z","caller":"traceutil/trace.go:171","msg":"trace[1070101527] transaction","detail":"{read_only:false; response_revision:1779; number_of_response:1; }","duration":"1.056667663s","start":"2026-03-03T11:02:05.014859Z","end":"2026-03-03T11:02:06.071526Z","steps":["trace[1070101527] 'process raft request'  (duration: 636.868943ms)","trace[1070101527] 'compare'  (duration: 419.254837ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T11:02:06.071676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:05.014833Z","time spent":"1.056783256s","remote":"127.0.0.1:53558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6863,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:1122 > success:<request_put:<key:\"/registry/minions/instance\" value_size:6829 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-03T11:02:06.071677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.876444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-03T11:02:06.071732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.104146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-03T11:02:06.071744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.0576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-03-03T11:02:06.071765Z","caller":"traceutil/trace.go:171","msg":"trace[1441702399] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1779; }","duration":"879.148967ms","start":"2026-03-03T11:02:05.192606Z","end":"2026-03-03T11:02:06.071755Z","steps":["trace[1441702399] 'agreement among raft nodes before linearized reading'  (duration: 879.001574ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:06.071804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:05.192599Z","time spent":"879.197818ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-03T11:02:06.0718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.179141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-03T11:02:06.071866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.459301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-03T11:02:06.071894Z","caller":"traceutil/trace.go:171","msg":"trace[935617178] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1779; }","duration":"433.560523ms","start":"2026-03-03T11:02:05.638325Z","end":"2026-03-03T11:02:06.071886Z","steps":["trace[935617178] 'agreement among raft nodes before linearized reading'  (duration: 433.42799ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T11:02:06.071893Z","caller":"traceutil/trace.go:171","msg":"trace[190157059] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1779; }","duration":"880.317695ms","start":"2026-03-03T11:02:05.191555Z","end":"2026-03-03T11:02:06.071872Z","steps":["trace[190157059] 'agreement among raft nodes before linearized reading'  (duration: 880.038208ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:06.071919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:05.638255Z","time spent":"433.658895ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-03T11:02:06.071935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:05.191537Z","time spent":"880.391776ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-03T11:02:06.071837Z","caller":"traceutil/trace.go:171","msg":"trace[1093247007] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1779; }","duration":"115.194573ms","start":"2026-03-03T11:02:05.956593Z","end":"2026-03-03T11:02:06.071788Z","steps":["trace[1093247007] 'agreement among raft nodes before linearized reading'  (duration: 115.032479ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:06.072042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.484291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2723"}
{"level":"info","ts":"2026-03-03T11:02:06.072078Z","caller":"traceutil/trace.go:171","msg":"trace[462784284] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1779; }","duration":"719.554043ms","start":"2026-03-03T11:02:05.352513Z","end":"2026-03-03T11:02:06.072067Z","steps":["trace[462784284] 'agreement among raft nodes before linearized reading'  (duration: 719.44694ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:06.072107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:05.352495Z","time spent":"719.605484ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":2745,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "}
{"level":"warn","ts":"2026-03-03T11:02:06.072143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.455995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-03T11:02:06.072171Z","caller":"traceutil/trace.go:171","msg":"trace[1457664760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1779; }","duration":"859.508267ms","start":"2026-03-03T11:02:05.212654Z","end":"2026-03-03T11:02:06.072162Z","steps":["trace[1457664760] 'agreement among raft nodes before linearized reading'  (duration: 859.437605ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:06.072174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.798157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-03T11:02:06.072189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:05.212641Z","time spent":"859.543327ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-03T11:02:06.071735Z","caller":"traceutil/trace.go:171","msg":"trace[207232715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1779; }","duration":"593.980026ms","start":"2026-03-03T11:02:05.477742Z","end":"2026-03-03T11:02:06.071722Z","steps":["trace[207232715] 'agreement among raft nodes before linearized reading'  (duration: 593.863244ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:06.072214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.82081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"}
{"level":"warn","ts":"2026-03-03T11:02:06.072248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:05.477723Z","time spent":"594.516389ms","remote":"127.0.0.1:53374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-03T11:02:06.072254Z","caller":"traceutil/trace.go:171","msg":"trace[469877596] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1779; }","duration":"875.895471ms","start":"2026-03-03T11:02:05.19635Z","end":"2026-03-03T11:02:06.072245Z","steps":["trace[469877596] 'agreement among raft nodes before linearized reading'  (duration: 875.735607ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:06.072284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:05.196336Z","time spent":"875.941402ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"info","ts":"2026-03-03T11:02:06.072348Z","caller":"traceutil/trace.go:171","msg":"trace[210777768] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1779; }","duration":"811.864999ms","start":"2026-03-03T11:02:05.260338Z","end":"2026-03-03T11:02:06.072203Z","steps":["trace[210777768] 'agreement among raft nodes before linearized reading'  (duration: 811.749496ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:06.072785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:05.260324Z","time spent":"812.053703ms","remote":"127.0.0.1:53652","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-03-03T11:02:06.802882Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039418802138534241,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-03T11:02:07.190283Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.113891376s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-03T11:02:07.195336Z","caller":"traceutil/trace.go:171","msg":"trace[50201848] transaction","detail":"{read_only:false; response_revision:1781; number_of_response:1; }","duration":"1.11783791s","start":"2026-03-03T11:02:06.077472Z","end":"2026-03-03T11:02:07.19531Z","steps":["trace[50201848] 'process raft request'  (duration: 1.117626775s)"],"step_count":1}
{"level":"info","ts":"2026-03-03T11:02:07.195403Z","caller":"traceutil/trace.go:171","msg":"trace[321860259] transaction","detail":"{read_only:false; response_revision:1783; number_of_response:1; }","duration":"1.11573199s","start":"2026-03-03T11:02:06.079642Z","end":"2026-03-03T11:02:07.195374Z","steps":["trace[321860259] 'process raft request'  (duration: 1.115573366s)"],"step_count":1}
{"level":"info","ts":"2026-03-03T11:02:07.195403Z","caller":"traceutil/trace.go:171","msg":"trace[1628346331] linearizableReadLoop","detail":"{readStateIndex:1867; appliedIndex:1860; }","duration":"892.717117ms","start":"2026-03-03T11:02:06.302662Z","end":"2026-03-03T11:02:07.195379Z","steps":["trace[1628346331] 'read index received'  (duration: 887.997886ms)","trace[1628346331] 'applied index is now lower than readState.Index'  (duration: 4.718171ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-03T11:02:07.195466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:06.077414Z","time spent":"1.117977753s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1767 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-03T11:02:07.195566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:06.07962Z","time spent":"1.115862833s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1769 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-03T11:02:07.195627Z","caller":"traceutil/trace.go:171","msg":"trace[747794066] transaction","detail":"{read_only:false; response_revision:1785; number_of_response:1; }","duration":"1.114582133s","start":"2026-03-03T11:02:06.081032Z","end":"2026-03-03T11:02:07.195614Z","steps":["trace[747794066] 'process raft request'  (duration: 1.114247555s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:07.195675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.005574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-03-03T11:02:07.195674Z","caller":"traceutil/trace.go:171","msg":"trace[995696207] transaction","detail":"{read_only:false; response_revision:1782; number_of_response:1; }","duration":"1.11701832s","start":"2026-03-03T11:02:06.078632Z","end":"2026-03-03T11:02:07.19565Z","steps":["trace[995696207] 'process raft request'  (duration: 1.116550959s)"],"step_count":1}
{"level":"info","ts":"2026-03-03T11:02:07.195707Z","caller":"traceutil/trace.go:171","msg":"trace[1124983396] transaction","detail":"{read_only:false; response_revision:1780; number_of_response:1; }","duration":"1.119414867s","start":"2026-03-03T11:02:06.076279Z","end":"2026-03-03T11:02:07.195694Z","steps":["trace[1124983396] 'process raft request'  (duration: 1.114250385s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:07.195715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:06.081008Z","time spent":"1.114648065s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" mod_revision:1749 > success:<request_put:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" value_size:433 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-03T11:02:07.195731Z","caller":"traceutil/trace.go:171","msg":"trace[740876314] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1786; }","duration":"893.115256ms","start":"2026-03-03T11:02:06.302601Z","end":"2026-03-03T11:02:07.195716Z","steps":["trace[740876314] 'agreement among raft nodes before linearized reading'  (duration: 892.949702ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:07.195773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:06.302575Z","time spent":"893.189988ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-03T11:02:07.195781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:06.078623Z","time spent":"1.117110103s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1770 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-03T11:02:07.195768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:06.076257Z","time spent":"1.119478018s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1766 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-03T11:02:07.195857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.442514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T11:02:07.195892Z","caller":"traceutil/trace.go:171","msg":"trace[1859362228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1786; }","duration":"717.522256ms","start":"2026-03-03T11:02:06.478361Z","end":"2026-03-03T11:02:07.195883Z","steps":["trace[1859362228] 'agreement among raft nodes before linearized reading'  (duration: 717.475165ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:07.195918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:06.478332Z","time spent":"717.581068ms","remote":"127.0.0.1:53374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-03T11:02:07.195873Z","caller":"traceutil/trace.go:171","msg":"trace[1496216110] transaction","detail":"{read_only:false; response_revision:1786; number_of_response:1; }","duration":"1.114414959s","start":"2026-03-03T11:02:06.081292Z","end":"2026-03-03T11:02:07.195707Z","steps":["trace[1496216110] 'process raft request'  (duration: 1.11402004s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:07.1961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.257978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T11:02:07.196121Z","caller":"traceutil/trace.go:171","msg":"trace[919490780] transaction","detail":"{read_only:false; response_revision:1784; number_of_response:1; }","duration":"1.116392465s","start":"2026-03-03T11:02:06.079717Z","end":"2026-03-03T11:02:07.196109Z","steps":["trace[919490780] 'process raft request'  (duration: 1.115531735s)"],"step_count":1}
{"level":"info","ts":"2026-03-03T11:02:07.196176Z","caller":"traceutil/trace.go:171","msg":"trace[1860870141] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1786; }","duration":"113.455552ms","start":"2026-03-03T11:02:07.08269Z","end":"2026-03-03T11:02:07.196146Z","steps":["trace[1860870141] 'agreement among raft nodes before linearized reading'  (duration: 113.278148ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:07.196116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:06.081283Z","time spent":"1.114749647s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1768 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:451 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >"}
{"level":"warn","ts":"2026-03-03T11:02:07.196233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:06.07971Z","time spent":"1.116488077s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1771 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-03T11:02:12.70706Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039418802138534303,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-03T11:02:13.207214Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039418802138534303,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-03T11:02:13.512081Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.306348342s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-03T11:02:13.512908Z","caller":"traceutil/trace.go:171","msg":"trace[531416496] linearizableReadLoop","detail":"{readStateIndex:1887; appliedIndex:1886; }","duration":"1.306161537s","start":"2026-03-03T11:02:12.206707Z","end":"2026-03-03T11:02:13.512869Z","steps":["trace[531416496] 'read index received'  (duration: 1.305791859s)","trace[531416496] 'applied index is now lower than readState.Index'  (duration: 368.348µs)"],"step_count":2}
{"level":"info","ts":"2026-03-03T11:02:13.513063Z","caller":"traceutil/trace.go:171","msg":"trace[624749622] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"1.307348985s","start":"2026-03-03T11:02:12.205603Z","end":"2026-03-03T11:02:13.512952Z","steps":["trace[624749622] 'process raft request'  (duration: 1.307009097s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:13.513425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.306608618s","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":"warn","ts":"2026-03-03T11:02:13.513343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037419392s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-03T11:02:13.513498Z","caller":"traceutil/trace.go:171","msg":"trace[784351198] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1805; }","duration":"1.306785183s","start":"2026-03-03T11:02:12.206694Z","end":"2026-03-03T11:02:13.513479Z","steps":["trace[784351198] 'agreement among raft nodes before linearized reading'  (duration: 1.306331922s)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:13.513514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.81746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-03T11:02:13.513517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.065146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-03T11:02:13.513564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:12.206689Z","time spent":"1.306859784s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-03-03T11:02:13.513616Z","caller":"traceutil/trace.go:171","msg":"trace[787400210] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1805; }","duration":"286.975564ms","start":"2026-03-03T11:02:13.226615Z","end":"2026-03-03T11:02:13.513591Z","steps":["trace[787400210] 'agreement among raft nodes before linearized reading'  (duration: 286.678237ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T11:02:13.513578Z","caller":"traceutil/trace.go:171","msg":"trace[122295237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1805; }","duration":"1.037724029s","start":"2026-03-03T11:02:12.475812Z","end":"2026-03-03T11:02:13.513536Z","steps":["trace[122295237] 'agreement among raft nodes before linearized reading'  (duration: 1.037367451s)"],"step_count":1}
{"level":"info","ts":"2026-03-03T11:02:13.513631Z","caller":"traceutil/trace.go:171","msg":"trace[316953884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1805; }","duration":"287.25095ms","start":"2026-03-03T11:02:13.226345Z","end":"2026-03-03T11:02:13.513596Z","steps":["trace[316953884] 'agreement among raft nodes before linearized reading'  (duration: 286.832811ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:13.513454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.145154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"}
{"level":"warn","ts":"2026-03-03T11:02:13.513835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:12.205581Z","time spent":"1.307608482s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" mod_revision:1785 > success:<request_put:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" value_size:432 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-03T11:02:13.513867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.284309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-03T11:02:13.513857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.850024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-03T11:02:13.513923Z","caller":"traceutil/trace.go:171","msg":"trace[608703562] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1805; }","duration":"287.939957ms","start":"2026-03-03T11:02:13.225966Z","end":"2026-03-03T11:02:13.513906Z","steps":["trace[608703562] 'agreement among raft nodes before linearized reading'  (duration: 287.795393ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T11:02:13.513945Z","caller":"traceutil/trace.go:171","msg":"trace[295695045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1805; }","duration":"289.37622ms","start":"2026-03-03T11:02:13.224517Z","end":"2026-03-03T11:02:13.513893Z","steps":["trace[295695045] 'agreement among raft nodes before linearized reading'  (duration: 289.271238ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:13.513928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.077875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.194\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-03T11:02:13.513984Z","caller":"traceutil/trace.go:171","msg":"trace[1018006510] range","detail":"{range_begin:/registry/masterleases/199.19.213.194; range_end:; response_count:1; response_revision:1805; }","duration":"974.162617ms","start":"2026-03-03T11:02:12.539809Z","end":"2026-03-03T11:02:13.513972Z","steps":["trace[1018006510] 'agreement among raft nodes before linearized reading'  (duration: 973.933412ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:13.514027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:12.539794Z","time spent":"974.225888ms","remote":"127.0.0.1:53416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.194\" "}
{"level":"warn","ts":"2026-03-03T11:02:13.513728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.711821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"}
{"level":"info","ts":"2026-03-03T11:02:13.514188Z","caller":"traceutil/trace.go:171","msg":"trace[417676617] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1805; }","duration":"288.170302ms","start":"2026-03-03T11:02:13.226002Z","end":"2026-03-03T11:02:13.514172Z","steps":["trace[417676617] 'agreement among raft nodes before linearized reading'  (duration: 287.573548ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T11:02:13.513845Z","caller":"traceutil/trace.go:171","msg":"trace[347547703] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1805; }","duration":"953.557384ms","start":"2026-03-03T11:02:12.560259Z","end":"2026-03-03T11:02:13.513817Z","steps":["trace[347547703] 'agreement among raft nodes before linearized reading'  (duration: 952.9993ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:13.515813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:12.560245Z","time spent":"955.54288ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-03T11:02:13.513515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.773543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-03T11:02:13.515963Z","caller":"traceutil/trace.go:171","msg":"trace[1191811510] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1805; }","duration":"290.272962ms","start":"2026-03-03T11:02:13.225671Z","end":"2026-03-03T11:02:13.515944Z","steps":["trace[1191811510] 'agreement among raft nodes before linearized reading'  (duration: 287.571458ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:13.513703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:12.47579Z","time spent":"1.037894262s","remote":"127.0.0.1:53374","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-03-03T11:02:22.842779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:22.540952Z","time spent":"301.822562ms","remote":"127.0.0.1:53416","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-03T11:02:38.703792Z","caller":"traceutil/trace.go:171","msg":"trace[1402282084] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"119.465103ms","start":"2026-03-03T11:02:38.584297Z","end":"2026-03-03T11:02:38.703762Z","steps":["trace[1402282084] 'process raft request'  (duration: 119.273439ms)"],"step_count":1}
{"level":"info","ts":"2026-03-03T11:02:39.24189Z","caller":"traceutil/trace.go:171","msg":"trace[68968848] linearizableReadLoop","detail":"{readStateIndex:2017; appliedIndex:2016; }","duration":"653.811342ms","start":"2026-03-03T11:02:38.588049Z","end":"2026-03-03T11:02:39.24186Z","steps":["trace[68968848] 'read index received'  (duration: 115.706345ms)","trace[68968848] 'applied index is now lower than readState.Index'  (duration: 538.103867ms)"],"step_count":2}
{"level":"info","ts":"2026-03-03T11:02:39.242017Z","caller":"traceutil/trace.go:171","msg":"trace[1617208171] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"654.709253ms","start":"2026-03-03T11:02:38.587295Z","end":"2026-03-03T11:02:39.242004Z","steps":["trace[1617208171] 'process raft request'  (duration: 654.312683ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:39.242138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:38.587281Z","time spent":"654.759264ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1905 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:438 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-03T11:02:39.242169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.615826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-03T11:02:39.242275Z","caller":"traceutil/trace.go:171","msg":"trace[265634977] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1928; }","duration":"445.79754ms","start":"2026-03-03T11:02:38.796455Z","end":"2026-03-03T11:02:39.242253Z","steps":["trace[265634977] 'agreement among raft nodes before linearized reading'  (duration: 445.572795ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:39.24232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:38.79643Z","time spent":"445.880003ms","remote":"127.0.0.1:53906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":23,"response size":29,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "}
{"level":"warn","ts":"2026-03-03T11:02:39.242252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.15752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-03-03T11:02:39.2424Z","caller":"traceutil/trace.go:171","msg":"trace[1647563509] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1928; }","duration":"654.340044ms","start":"2026-03-03T11:02:38.588027Z","end":"2026-03-03T11:02:39.242367Z","steps":["trace[1647563509] 'agreement among raft nodes before linearized reading'  (duration: 653.992736ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-03T11:02:39.242473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T11:02:38.588005Z","time spent":"654.454597ms","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}