{"level":"warn","ts":"2026-03-20T10:12:26.438815Z","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-20T10:12:26.438999Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-20T10:12:26.439182Z","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-20T10:12:26.439292Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]}
{"level":"info","ts":"2026-03-20T10:12:26.43939Z","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-20T10:12:26.440213Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]}
{"level":"info","ts":"2026-03-20T10:12:26.440403Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-20T10:12:26.445148Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.352957ms"}
{"level":"info","ts":"2026-03-20T10:12:26.451807Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"}
{"level":"info","ts":"2026-03-20T10:12:26.452239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-20T10:12:26.452331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"}
{"level":"info","ts":"2026-03-20T10:12:26.452385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-20T10:12:26.452457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"}
{"level":"info","ts":"2026-03-20T10:12:26.452571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"}
{"level":"warn","ts":"2026-03-20T10:12:26.459829Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-20T10:12:26.462099Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-20T10:12:26.463261Z","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-20T10:12:26.465524Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-20T10:12:26.465734Z","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-20T10:12:26.465817Z","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-20T10:12:26.46583Z","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-20T10:12:26.46623Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-20T10:12:26.470754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"}
{"level":"info","ts":"2026-03-20T10:12:26.470879Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]}
{"level":"info","ts":"2026-03-20T10:12:26.470997Z","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-20T10:12:26.471019Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"}
{"level":"info","ts":"2026-03-20T10:12:26.471158Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"}
{"level":"info","ts":"2026-03-20T10:12:26.471447Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-20T10:12:26.471521Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-20T10:12:27.153117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-20T10:12:27.153173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-20T10:12:27.153214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"}
{"level":"info","ts":"2026-03-20T10:12:27.153242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"}
{"level":"info","ts":"2026-03-20T10:12:27.153258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"}
{"level":"info","ts":"2026-03-20T10:12:27.153274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"}
{"level":"info","ts":"2026-03-20T10:12:27.15329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"}
{"level":"info","ts":"2026-03-20T10:12:27.154464Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:12:27.155674Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T10:12:27.155671Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-20T10:12:27.155725Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T10:12:27.155966Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-20T10:12:27.155986Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-20T10:12:27.15603Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:12:27.156144Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:12:27.156171Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:12:27.158673Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-20T10:12:27.16563Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"}
{"level":"info","ts":"2026-03-20T10:12:51.255976Z","caller":"traceutil/trace.go:171","msg":"trace[1241942497] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"238.802334ms","start":"2026-03-20T10:12:51.017138Z","end":"2026-03-20T10:12:51.25594Z","steps":["trace[1241942497] 'process raft request'  (duration: 238.378692ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:12:52.056367Z","caller":"traceutil/trace.go:171","msg":"trace[1733979051] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"144.704152ms","start":"2026-03-20T10:12:51.91164Z","end":"2026-03-20T10:12:52.056344Z","steps":["trace[1733979051] 'process raft request'  (duration: 144.566939ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:12:54.845115Z","caller":"traceutil/trace.go:171","msg":"trace[406702605] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"194.138333ms","start":"2026-03-20T10:12:54.650944Z","end":"2026-03-20T10:12:54.845082Z","steps":["trace[406702605] 'process raft request'  (duration: 193.842434ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:12:55.588527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.498348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:12:55.588618Z","caller":"traceutil/trace.go:171","msg":"trace[1087162336] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:490; }","duration":"376.636901ms","start":"2026-03-20T10:12:55.21196Z","end":"2026-03-20T10:12:55.588597Z","steps":["trace[1087162336] 'range keys from in-memory index tree'  (duration: 376.372674ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:12:55.588603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.160896ms","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-20T10:12:55.588644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:12:55.211939Z","time spent":"376.698912ms","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-20T10:12:55.588696Z","caller":"traceutil/trace.go:171","msg":"trace[2142055694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:490; }","duration":"319.30168ms","start":"2026-03-20T10:12:55.269369Z","end":"2026-03-20T10:12:55.588671Z","steps":["trace[2142055694] 'range keys from in-memory index tree'  (duration: 318.977661ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:12:55.588749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:12:55.269348Z","time spent":"319.391861ms","remote":"127.0.0.1:35006","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-20T10:12:55.735529Z","caller":"traceutil/trace.go:171","msg":"trace[1702776402] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"143.270904ms","start":"2026-03-20T10:12:55.592224Z","end":"2026-03-20T10:12:55.735495Z","steps":["trace[1702776402] 'process raft request'  (duration: 143.144721ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:12:55.735887Z","caller":"traceutil/trace.go:171","msg":"trace[1430321691] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:505; }","duration":"146.324335ms","start":"2026-03-20T10:12:55.589532Z","end":"2026-03-20T10:12:55.735856Z","steps":["trace[1430321691] 'read index received'  (duration: 54.011912ms)","trace[1430321691] 'applied index is now lower than readState.Index'  (duration: 92.309323ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:12:55.737401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.274097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4374"}
{"level":"warn","ts":"2026-03-20T10:12:55.737453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.915308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:12:55.737482Z","caller":"traceutil/trace.go:171","msg":"trace[1089812747] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:491; }","duration":"142.38499ms","start":"2026-03-20T10:12:55.595066Z","end":"2026-03-20T10:12:55.737451Z","steps":["trace[1089812747] 'agreement among raft nodes before linearized reading'  (duration: 140.921712ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:12:55.73752Z","caller":"traceutil/trace.go:171","msg":"trace[115319939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:491; }","duration":"148.017942ms","start":"2026-03-20T10:12:55.589487Z","end":"2026-03-20T10:12:55.737505Z","steps":["trace[115319939] 'agreement among raft nodes before linearized reading'  (duration: 146.45422ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:12:58.688979Z","caller":"traceutil/trace.go:171","msg":"trace[601231479] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:512; }","duration":"478.056ms","start":"2026-03-20T10:12:58.210901Z","end":"2026-03-20T10:12:58.688957Z","steps":["trace[601231479] 'read index received'  (duration: 477.874906ms)","trace[601231479] 'applied index is now lower than readState.Index'  (duration: 180.164µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:12:58.689027Z","caller":"traceutil/trace.go:171","msg":"trace[1253627512] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"494.579375ms","start":"2026-03-20T10:12:58.194417Z","end":"2026-03-20T10:12:58.688996Z","steps":["trace[1253627512] 'process raft request'  (duration: 494.4113ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:12:58.689092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.167673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:12:58.689137Z","caller":"traceutil/trace.go:171","msg":"trace[540273295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:497; }","duration":"478.243035ms","start":"2026-03-20T10:12:58.210871Z","end":"2026-03-20T10:12:58.689114Z","steps":["trace[540273295] 'agreement among raft nodes before linearized reading'  (duration: 478.172653ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:12:58.689179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:12:58.210858Z","time spent":"478.311716ms","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:12:58.689677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:12:58.194397Z","time spent":"494.699397ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:493 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-20T10:12:59.22371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.818954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-20T10:12:59.223794Z","caller":"traceutil/trace.go:171","msg":"trace[398219994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:497; }","duration":"303.941617ms","start":"2026-03-20T10:12:58.919835Z","end":"2026-03-20T10:12:59.223776Z","steps":["trace[398219994] 'range keys from in-memory index tree'  (duration: 303.74211ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:12:59.223932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:12:58.919825Z","time spent":"304.09681ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-20T10:12:59.223911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.31817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T10:12:59.224029Z","caller":"traceutil/trace.go:171","msg":"trace[1558670072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:497; }","duration":"364.473105ms","start":"2026-03-20T10:12:58.859529Z","end":"2026-03-20T10:12:59.224002Z","steps":["trace[1558670072] 'range keys from in-memory index tree'  (duration: 364.246498ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:12:59.224081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:12:58.859518Z","time spent":"364.548156ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-20T10:13:03.093492Z","caller":"traceutil/trace.go:171","msg":"trace[833578996] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"124.834517ms","start":"2026-03-20T10:13:02.968612Z","end":"2026-03-20T10:13:03.093446Z","steps":["trace[833578996] 'process raft request'  (duration: 124.581681ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:03.745121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.91612ms","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-20T10:13:03.745239Z","caller":"traceutil/trace.go:171","msg":"trace[662245779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:512; }","duration":"490.137516ms","start":"2026-03-20T10:13:03.255069Z","end":"2026-03-20T10:13:03.745207Z","steps":["trace[662245779] 'range keys from in-memory index tree'  (duration: 489.796816ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:03.745296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:03.255058Z","time spent":"490.223578ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-20T10:13:03.745422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.274707ms","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-20T10:13:03.745546Z","caller":"traceutil/trace.go:171","msg":"trace[1761767669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:512; }","duration":"491.42868ms","start":"2026-03-20T10:13:03.254089Z","end":"2026-03-20T10:13:03.745518Z","steps":["trace[1761767669] 'range keys from in-memory index tree'  (duration: 491.150343ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:03.745597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:03.254022Z","time spent":"491.564215ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-20T10:13:03.851346Z","caller":"traceutil/trace.go:171","msg":"trace[1192717182] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"100.807635ms","start":"2026-03-20T10:13:03.750524Z","end":"2026-03-20T10:13:03.851332Z","steps":["trace[1192717182] 'process raft request'  (duration: 98.187765ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:04.712286Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512260740569210,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:13:05.907183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.133464657s","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740569211 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:506 > 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-20T10:13:05.907286Z","caller":"traceutil/trace.go:171","msg":"trace[2127247499] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:531; }","duration":"1.695522587s","start":"2026-03-20T10:13:04.211746Z","end":"2026-03-20T10:13:05.907268Z","steps":["trace[2127247499] 'read index received'  (duration: 561.272198ms)","trace[2127247499] 'applied index is now lower than readState.Index'  (duration: 1.134249209s)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:13:05.907361Z","caller":"traceutil/trace.go:171","msg":"trace[1840129888] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"2.052074261s","start":"2026-03-20T10:13:03.855275Z","end":"2026-03-20T10:13:05.907349Z","steps":["trace[1840129888] 'process raft request'  (duration: 917.809402ms)","trace[1840129888] 'compare'  (duration: 1.133288393s)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:13:05.907413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:03.855264Z","time spent":"2.052120032s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:506 > 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-20T10:13:05.907488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.695730612s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:13:05.907564Z","caller":"traceutil/trace.go:171","msg":"trace[2022131100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"1.695849866s","start":"2026-03-20T10:13:04.21169Z","end":"2026-03-20T10:13:05.90754Z","steps":["trace[2022131100] 'agreement among raft nodes before linearized reading'  (duration: 1.695733313s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:05.907603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:04.211667Z","time spent":"1.695928508s","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:13:05.990678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.439178ms","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-20T10:13:05.990672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.196097553s","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-20T10:13:05.990734Z","caller":"traceutil/trace.go:171","msg":"trace[1886572436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"148.537461ms","start":"2026-03-20T10:13:05.842183Z","end":"2026-03-20T10:13:05.990721Z","steps":["trace[1886572436] 'agreement among raft nodes before linearized reading'  (duration: 148.420918ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:13:05.990761Z","caller":"traceutil/trace.go:171","msg":"trace[1281775374] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:515; }","duration":"1.196235516s","start":"2026-03-20T10:13:04.794506Z","end":"2026-03-20T10:13:05.990741Z","steps":["trace[1281775374] 'agreement among raft nodes before linearized reading'  (duration: 1.196089802s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:05.990803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:04.79445Z","time spent":"1.19634453s","remote":"127.0.0.1:35006","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-20T10:13:05.99081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.747931ms","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-20T10:13:05.99088Z","caller":"traceutil/trace.go:171","msg":"trace[1610604701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"135.839302ms","start":"2026-03-20T10:13:05.855019Z","end":"2026-03-20T10:13:05.990859Z","steps":["trace[1610604701] 'agreement among raft nodes before linearized reading'  (duration: 135.726139ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:07.334178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.28581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:13:07.33426Z","caller":"traceutil/trace.go:171","msg":"trace[1309953823] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"122.417763ms","start":"2026-03-20T10:13:07.211823Z","end":"2026-03-20T10:13:07.334241Z","steps":["trace[1309953823] 'range keys from in-memory index tree'  (duration: 122.217149ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:13:11.282118Z","caller":"traceutil/trace.go:171","msg":"trace[734589803] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"137.691013ms","start":"2026-03-20T10:13:11.144345Z","end":"2026-03-20T10:13:11.282036Z","steps":["trace[734589803] 'process raft request'  (duration: 136.925571ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:13:24.136988Z","caller":"traceutil/trace.go:171","msg":"trace[1023611355] linearizableReadLoop","detail":"{readStateIndex:717; appliedIndex:716; }","duration":"120.539153ms","start":"2026-03-20T10:13:24.016423Z","end":"2026-03-20T10:13:24.136962Z","steps":["trace[1023611355] 'read index received'  (duration: 120.286876ms)","trace[1023611355] 'applied index is now lower than readState.Index'  (duration: 250.987µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:13:24.137059Z","caller":"traceutil/trace.go:171","msg":"trace[1643320779] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"496.719463ms","start":"2026-03-20T10:13:23.64031Z","end":"2026-03-20T10:13:24.137029Z","steps":["trace[1643320779] 'process raft request'  (duration: 496.500747ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:24.137252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:23.640286Z","time spent":"496.846726ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:689 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-20T10:13:24.137377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.929632ms","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-20T10:13:24.137471Z","caller":"traceutil/trace.go:171","msg":"trace[1671606370] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:695; }","duration":"121.086577ms","start":"2026-03-20T10:13:24.01636Z","end":"2026-03-20T10:13:24.137447Z","steps":["trace[1671606370] 'agreement among raft nodes before linearized reading'  (duration: 120.77213ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:24.711869Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512260740569557,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:13:25.212996Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512260740569557,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-20T10:13:25.405848Z","caller":"traceutil/trace.go:171","msg":"trace[176986459] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"1.264272744s","start":"2026-03-20T10:13:24.14155Z","end":"2026-03-20T10:13:25.405823Z","steps":["trace[176986459] 'process raft request'  (duration: 1.264012737s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:25.40601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:24.141533Z","time spent":"1.264402058s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:691 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-20T10:13:25.42814Z","caller":"traceutil/trace.go:171","msg":"trace[1524686766] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"1.28505809s","start":"2026-03-20T10:13:24.143067Z","end":"2026-03-20T10:13:25.428126Z","steps":["trace[1524686766] 'process raft request'  (duration: 1.284965858s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:25.428212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:24.143037Z","time spent":"1.285140953s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:692 > 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-20T10:13:25.428412Z","caller":"traceutil/trace.go:171","msg":"trace[1680374598] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"1.285246145s","start":"2026-03-20T10:13:24.143139Z","end":"2026-03-20T10:13:25.428385Z","steps":["trace[1680374598] 'process raft request'  (duration: 1.284961638s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:25.428544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:24.143106Z","time spent":"1.285367908s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:690 > 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-20T10:13:25.428525Z","caller":"traceutil/trace.go:171","msg":"trace[1239868645] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:717; }","duration":"1.216911887s","start":"2026-03-20T10:13:24.211569Z","end":"2026-03-20T10:13:25.42848Z","steps":["trace[1239868645] 'read index received'  (duration: 1.194144209s)","trace[1239868645] 'applied index is now lower than readState.Index'  (duration: 22.765868ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:13:25.428741Z","caller":"traceutil/trace.go:171","msg":"trace[1421012059] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"1.285137523s","start":"2026-03-20T10:13:24.143591Z","end":"2026-03-20T10:13:25.428728Z","steps":["trace[1421012059] 'process raft request'  (duration: 1.284736232s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:25.428759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.217161534s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:13:25.428797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:24.143579Z","time spent":"1.285193825s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:693 > 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-20T10:13:25.428818Z","caller":"traceutil/trace.go:171","msg":"trace[1760891718] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:699; }","duration":"1.217292448s","start":"2026-03-20T10:13:24.21151Z","end":"2026-03-20T10:13:25.428803Z","steps":["trace[1760891718] 'agreement among raft nodes before linearized reading'  (duration: 1.217119774s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:25.428866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:24.211494Z","time spent":"1.21736287s","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-20T10:13:26.299502Z","caller":"traceutil/trace.go:171","msg":"trace[54173721] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"149.558389ms","start":"2026-03-20T10:13:26.14991Z","end":"2026-03-20T10:13:26.299468Z","steps":["trace[54173721] 'process raft request'  (duration: 149.321313ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:13:27.434636Z","caller":"traceutil/trace.go:171","msg":"trace[361586131] linearizableReadLoop","detail":"{readStateIndex:724; appliedIndex:723; }","duration":"224.469481ms","start":"2026-03-20T10:13:27.210134Z","end":"2026-03-20T10:13:27.434603Z","steps":["trace[361586131] 'read index received'  (duration: 224.162663ms)","trace[361586131] 'applied index is now lower than readState.Index'  (duration: 305.288µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:13:27.434819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.668178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:13:27.434894Z","caller":"traceutil/trace.go:171","msg":"trace[1817781078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:701; }","duration":"224.806471ms","start":"2026-03-20T10:13:27.210076Z","end":"2026-03-20T10:13:27.434882Z","steps":["trace[1817781078] 'agreement among raft nodes before linearized reading'  (duration: 224.632286ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:13:27.4352Z","caller":"traceutil/trace.go:171","msg":"trace[225130597] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"258.893813ms","start":"2026-03-20T10:13:27.175759Z","end":"2026-03-20T10:13:27.434652Z","steps":["trace[225130597] 'process raft request'  (duration: 258.565504ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:28.298829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.686586ms","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-20T10:13:28.29907Z","caller":"traceutil/trace.go:171","msg":"trace[1574103934] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:701; }","duration":"663.946962ms","start":"2026-03-20T10:13:27.635088Z","end":"2026-03-20T10:13:28.299035Z","steps":["trace[1574103934] 'range keys from in-memory index tree'  (duration: 663.660204ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:13:28.312566Z","caller":"traceutil/trace.go:171","msg":"trace[1242937351] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"873.400663ms","start":"2026-03-20T10:13:27.439144Z","end":"2026-03-20T10:13:28.312545Z","steps":["trace[1242937351] 'process raft request'  (duration: 873.2714ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:28.31271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:27.439123Z","time spent":"873.499986ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:696 > 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-20T10:13:28.331226Z","caller":"traceutil/trace.go:171","msg":"trace[71692682] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"891.652101ms","start":"2026-03-20T10:13:27.439548Z","end":"2026-03-20T10:13:28.3312Z","steps":["trace[71692682] 'process raft request'  (duration: 891.474916ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:28.331384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:27.439532Z","time spent":"891.766333ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:697 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:13:28.331683Z","caller":"traceutil/trace.go:171","msg":"trace[1680698386] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"891.794905ms","start":"2026-03-20T10:13:27.439865Z","end":"2026-03-20T10:13:28.33166Z","steps":["trace[1680698386] 'process raft request'  (duration: 891.292201ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:13:28.331771Z","caller":"traceutil/trace.go:171","msg":"trace[1423774552] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"890.902861ms","start":"2026-03-20T10:13:27.440852Z","end":"2026-03-20T10:13:28.331754Z","steps":["trace[1423774552] 'process raft request'  (duration: 890.555592ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:28.331824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:27.439858Z","time spent":"891.893777ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:699 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-20T10:13:28.331846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:27.440835Z","time spent":"890.975082ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:698 > 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-20T10:13:50.731573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.352994ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740569762 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.22\" mod_revision:742 > success:<request_put:<key:\"/registry/masterleases/199.204.45.22\" value_size:66 lease:1011512260740569760 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.22\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:13:50.731725Z","caller":"traceutil/trace.go:171","msg":"trace[214637570] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:796; }","duration":"294.368903ms","start":"2026-03-20T10:13:50.437335Z","end":"2026-03-20T10:13:50.731704Z","steps":["trace[214637570] 'read index received'  (duration: 49.412µs)","trace[214637570] 'applied index is now lower than readState.Index'  (duration: 294.318041ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:13:50.731805Z","caller":"traceutil/trace.go:171","msg":"trace[1188451066] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"452.418438ms","start":"2026-03-20T10:13:50.279374Z","end":"2026-03-20T10:13:50.731792Z","steps":["trace[1188451066] 'process raft request'  (duration: 47.719697ms)","trace[1188451066] 'compare'  (duration: 404.197588ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:13:50.731874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:50.27934Z","time spent":"452.501021ms","remote":"127.0.0.1:34728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.22\" mod_revision:742 > success:<request_put:<key:\"/registry/masterleases/199.204.45.22\" value_size:66 lease:1011512260740569760 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.22\" > >"}
{"level":"warn","ts":"2026-03-20T10:13:50.732158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.797373ms","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-20T10:13:50.73227Z","caller":"traceutil/trace.go:171","msg":"trace[1901956838] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:769; }","duration":"294.956857ms","start":"2026-03-20T10:13:50.437276Z","end":"2026-03-20T10:13:50.732233Z","steps":["trace[1901956838] 'agreement among raft nodes before linearized reading'  (duration: 294.557647ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:51.759873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.03462ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740569763 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:741 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:13:51.760126Z","caller":"traceutil/trace.go:171","msg":"trace[1280720991] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"1.023038866s","start":"2026-03-20T10:13:50.737066Z","end":"2026-03-20T10:13:51.760105Z","steps":["trace[1280720991] 'process raft request'  (duration: 1.022949274s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:51.76023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:50.73705Z","time spent":"1.023130817s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:764 > 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-20T10:13:51.760426Z","caller":"traceutil/trace.go:171","msg":"trace[1674586907] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:797; }","duration":"1.028615564s","start":"2026-03-20T10:13:50.731757Z","end":"2026-03-20T10:13:51.760372Z","steps":["trace[1674586907] 'read index received'  (duration: 426.977317ms)","trace[1674586907] 'applied index is now lower than readState.Index'  (duration: 601.635237ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:13:51.760505Z","caller":"traceutil/trace.go:171","msg":"trace[1746584252] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"1.302594041s","start":"2026-03-20T10:13:50.457885Z","end":"2026-03-20T10:13:51.760479Z","steps":["trace[1746584252] 'process raft request'  (duration: 700.750108ms)","trace[1746584252] 'compare'  (duration: 600.138277ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:13:51.760598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:50.457867Z","time spent":"1.302689683s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:741 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-20T10:13:51.760733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.684895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:13:51.76074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.275231599s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-20T10:13:51.760783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024602387s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"}
{"level":"warn","ts":"2026-03-20T10:13:51.760801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.315086066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-20T10:13:51.76085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.318489306s","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-20T10:13:51.760849Z","caller":"traceutil/trace.go:171","msg":"trace[1049301314] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:771; }","duration":"1.275435175s","start":"2026-03-20T10:13:50.485386Z","end":"2026-03-20T10:13:51.760822Z","steps":["trace[1049301314] 'agreement among raft nodes before linearized reading'  (duration: 1.275055495s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:13:51.760871Z","caller":"traceutil/trace.go:171","msg":"trace[1263836188] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:771; }","duration":"1.024780302s","start":"2026-03-20T10:13:50.73606Z","end":"2026-03-20T10:13:51.76084Z","steps":["trace[1263836188] 'agreement among raft nodes before linearized reading'  (duration: 1.024581566s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:13:51.760903Z","caller":"traceutil/trace.go:171","msg":"trace[1352613713] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:771; }","duration":"1.318564088s","start":"2026-03-20T10:13:50.442325Z","end":"2026-03-20T10:13:51.760889Z","steps":["trace[1352613713] 'agreement among raft nodes before linearized reading'  (duration: 1.318303451s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:51.760864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.053982153s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:13:51.760923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:50.736029Z","time spent":"1.024883424s","remote":"127.0.0.1:34884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"warn","ts":"2026-03-20T10:13:51.760922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:50.485344Z","time spent":"1.275568258s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-20T10:13:51.760996Z","caller":"traceutil/trace.go:171","msg":"trace[962481554] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:771; }","duration":"1.054217439s","start":"2026-03-20T10:13:50.70674Z","end":"2026-03-20T10:13:51.760958Z","steps":["trace[962481554] 'agreement among raft nodes before linearized reading'  (duration: 1.053939801s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:13:51.760927Z","caller":"traceutil/trace.go:171","msg":"trace[1547390624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:771; }","duration":"1.31523831s","start":"2026-03-20T10:13:50.445648Z","end":"2026-03-20T10:13:51.760886Z","steps":["trace[1547390624] 'agreement among raft nodes before linearized reading'  (duration: 1.314857259s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:51.761087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:50.706695Z","time spent":"1.054368364s","remote":"127.0.0.1:34962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"info","ts":"2026-03-20T10:13:51.760764Z","caller":"traceutil/trace.go:171","msg":"trace[2020418151] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:771; }","duration":"547.755226ms","start":"2026-03-20T10:13:51.212998Z","end":"2026-03-20T10:13:51.760753Z","steps":["trace[2020418151] 'agreement among raft nodes before linearized reading'  (duration: 547.698184ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:51.76118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:51.212976Z","time spent":"548.195339ms","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:13:51.761185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:50.44564Z","time spent":"1.315480566s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-20T10:13:51.760943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:50.442315Z","time spent":"1.31862002s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-20T10:13:51.761137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.316031221s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T10:13:51.761582Z","caller":"traceutil/trace.go:171","msg":"trace[104025361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:771; }","duration":"1.31642111s","start":"2026-03-20T10:13:50.445047Z","end":"2026-03-20T10:13:51.761468Z","steps":["trace[104025361] 'agreement among raft nodes before linearized reading'  (duration: 1.315541286s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:51.761628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:50.445017Z","time spent":"1.316599845s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-20T10:13:51.926441Z","caller":"traceutil/trace.go:171","msg":"trace[1028987265] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"158.385486ms","start":"2026-03-20T10:13:51.768026Z","end":"2026-03-20T10:13:51.926412Z","steps":["trace[1028987265] 'process raft request'  (duration: 103.604381ms)","trace[1028987265] 'compare'  (duration: 54.623031ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:13:51.926821Z","caller":"traceutil/trace.go:171","msg":"trace[105685992] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"158.61845ms","start":"2026-03-20T10:13:51.76817Z","end":"2026-03-20T10:13:51.926788Z","steps":["trace[105685992] 'process raft request'  (duration: 158.185759ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:13:51.927057Z","caller":"traceutil/trace.go:171","msg":"trace[1115319582] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"158.651893ms","start":"2026-03-20T10:13:51.768352Z","end":"2026-03-20T10:13:51.927004Z","steps":["trace[1115319582] 'process raft request'  (duration: 158.362105ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:13:53.910204Z","caller":"traceutil/trace.go:171","msg":"trace[375197102] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:803; }","duration":"380.514954ms","start":"2026-03-20T10:13:53.52966Z","end":"2026-03-20T10:13:53.910175Z","steps":["trace[375197102] 'read index received'  (duration: 380.284128ms)","trace[375197102] 'applied index is now lower than readState.Index'  (duration: 230.006µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:13:53.910254Z","caller":"traceutil/trace.go:171","msg":"trace[1021367071] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"444.995408ms","start":"2026-03-20T10:13:53.465217Z","end":"2026-03-20T10:13:53.910212Z","steps":["trace[1021367071] 'process raft request'  (duration: 444.808223ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:53.910775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.215589ms","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-20T10:13:53.910896Z","caller":"traceutil/trace.go:171","msg":"trace[859830374] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:776; }","duration":"143.413175ms","start":"2026-03-20T10:13:53.767456Z","end":"2026-03-20T10:13:53.910869Z","steps":["trace[859830374] 'agreement among raft nodes before linearized reading'  (duration: 143.046474ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:53.910847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:53.465184Z","time spent":"445.537033ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:753 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-20T10:13:53.911401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.718316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T10:13:53.911467Z","caller":"traceutil/trace.go:171","msg":"trace[1850097760] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:776; }","duration":"381.807899ms","start":"2026-03-20T10:13:53.529645Z","end":"2026-03-20T10:13:53.911453Z","steps":["trace[1850097760] 'agreement among raft nodes before linearized reading'  (duration: 380.72512ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:53.911506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:53.529551Z","time spent":"381.942812ms","remote":"127.0.0.1:35114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:13:54.200808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.478515ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740569780 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:771 > 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-20T10:13:54.200998Z","caller":"traceutil/trace.go:171","msg":"trace[3717115] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:804; }","duration":"269.788284ms","start":"2026-03-20T10:13:53.93119Z","end":"2026-03-20T10:13:54.200978Z","steps":["trace[3717115] 'read index received'  (duration: 27.064684ms)","trace[3717115] 'applied index is now lower than readState.Index'  (duration: 242.722569ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:13:54.201173Z","caller":"traceutil/trace.go:171","msg":"trace[753980656] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"285.356631ms","start":"2026-03-20T10:13:53.915778Z","end":"2026-03-20T10:13:54.201134Z","steps":["trace[753980656] 'process raft request'  (duration: 42.459986ms)","trace[753980656] 'compare'  (duration: 242.208117ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:13:54.20128Z","caller":"traceutil/trace.go:171","msg":"trace[731200804] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"284.296413ms","start":"2026-03-20T10:13:53.916968Z","end":"2026-03-20T10:13:54.201265Z","steps":["trace[731200804] 'process raft request'  (duration: 283.950853ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:54.201535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.329729ms","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-20T10:13:54.201628Z","caller":"traceutil/trace.go:171","msg":"trace[2031594058] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:778; }","duration":"270.496703ms","start":"2026-03-20T10:13:53.931112Z","end":"2026-03-20T10:13:54.201609Z","steps":["trace[2031594058] 'agreement among raft nodes before linearized reading'  (duration: 270.221956ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:54.201801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.664781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T10:13:54.201847Z","caller":"traceutil/trace.go:171","msg":"trace[830976032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:778; }","duration":"269.731842ms","start":"2026-03-20T10:13:53.932104Z","end":"2026-03-20T10:13:54.201836Z","steps":["trace[830976032] 'agreement among raft nodes before linearized reading'  (duration: 269.597408ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:54.202103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.349966ms","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-20T10:13:54.202187Z","caller":"traceutil/trace.go:171","msg":"trace[12644550] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:778; }","duration":"268.483569ms","start":"2026-03-20T10:13:53.933684Z","end":"2026-03-20T10:13:54.202167Z","steps":["trace[12644550] 'agreement among raft nodes before linearized reading'  (duration: 268.109319ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:54.736694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.577617ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740569784 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:773 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:13:54.737178Z","caller":"traceutil/trace.go:171","msg":"trace[581204280] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"530.222828ms","start":"2026-03-20T10:13:54.2069Z","end":"2026-03-20T10:13:54.737122Z","steps":["trace[581204280] 'process raft request'  (duration: 97.092906ms)","trace[581204280] 'compare'  (duration: 432.449424ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:13:54.737442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:54.206874Z","time spent":"530.442405ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:773 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:13:54.73721Z","caller":"traceutil/trace.go:171","msg":"trace[1168707618] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"529.213841ms","start":"2026-03-20T10:13:54.207976Z","end":"2026-03-20T10:13:54.73719Z","steps":["trace[1168707618] 'process raft request'  (duration: 529.167461ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:54.73782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:54.207931Z","time spent":"529.756145ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:775 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:13:54.737252Z","caller":"traceutil/trace.go:171","msg":"trace[737951675] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"530.160486ms","start":"2026-03-20T10:13:54.207083Z","end":"2026-03-20T10:13:54.737243Z","steps":["trace[737951675] 'process raft request'  (duration: 529.716945ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:54.738048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:54.207061Z","time spent":"530.848594ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:774 > 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-20T10:14:11.354824Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512260740570016,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:14:11.855161Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512260740570016,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:14:11.883989Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.032555222s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T10:14:11.884289Z","caller":"traceutil/trace.go:171","msg":"trace[382412418] linearizableReadLoop","detail":"{readStateIndex:910; appliedIndex:909; }","duration":"1.029812016s","start":"2026-03-20T10:14:10.854458Z","end":"2026-03-20T10:14:11.88427Z","steps":["trace[382412418] 'read index received'  (duration: 1.029672672s)","trace[382412418] 'applied index is now lower than readState.Index'  (duration: 138.604µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:11.884352Z","caller":"traceutil/trace.go:171","msg":"trace[836477304] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"1.032973723s","start":"2026-03-20T10:14:10.851371Z","end":"2026-03-20T10:14:11.884345Z","steps":["trace[836477304] 'process raft request'  (duration: 1.032800778s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:11.884442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:10.851359Z","time spent":"1.033016514s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:870 > 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-20T10:14:11.884601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.402732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:14:11.884641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.030172116s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-20T10:14:11.884619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.739021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T10:14:11.884689Z","caller":"traceutil/trace.go:171","msg":"trace[1655781102] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:876; }","duration":"1.030256129s","start":"2026-03-20T10:14:10.854419Z","end":"2026-03-20T10:14:11.884675Z","steps":["trace[1655781102] 'agreement among raft nodes before linearized reading'  (duration: 1.030123644s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:11.884688Z","caller":"traceutil/trace.go:171","msg":"trace[1646530202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:876; }","duration":"673.543036ms","start":"2026-03-20T10:14:11.21112Z","end":"2026-03-20T10:14:11.884663Z","steps":["trace[1646530202] 'agreement among raft nodes before linearized reading'  (duration: 673.411393ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:11.884715Z","caller":"traceutil/trace.go:171","msg":"trace[894246851] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:876; }","duration":"321.916445ms","start":"2026-03-20T10:14:11.562777Z","end":"2026-03-20T10:14:11.884694Z","steps":["trace[894246851] 'agreement among raft nodes before linearized reading'  (duration: 321.706739ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:11.88474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:11.211091Z","time spent":"673.63862ms","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:14:11.88474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:10.8544Z","time spent":"1.030327409s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-20T10:14:11.884762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:11.562752Z","time spent":"322.000747ms","remote":"127.0.0.1:35136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:14:11.885016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.02742828s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T10:14:11.885065Z","caller":"traceutil/trace.go:171","msg":"trace[560591530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:876; }","duration":"1.027498552s","start":"2026-03-20T10:14:10.857551Z","end":"2026-03-20T10:14:11.88505Z","steps":["trace[560591530] 'agreement among raft nodes before linearized reading'  (duration: 1.026818704s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:11.885111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:10.857542Z","time spent":"1.027557533s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-20T10:14:12.681407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.594679ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570021 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:871 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:12.681561Z","caller":"traceutil/trace.go:171","msg":"trace[1892712766] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"793.263866ms","start":"2026-03-20T10:14:11.888273Z","end":"2026-03-20T10:14:12.681537Z","steps":["trace[1892712766] 'process raft request'  (duration: 670.434051ms)","trace[1892712766] 'compare'  (duration: 122.327851ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:12.68165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:11.888256Z","time spent":"793.353388ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:871 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:14:12.703689Z","caller":"traceutil/trace.go:171","msg":"trace[1167069853] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"813.531853ms","start":"2026-03-20T10:14:11.890128Z","end":"2026-03-20T10:14:12.70366Z","steps":["trace[1167069853] 'process raft request'  (duration: 813.350238ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:12.703857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:11.890106Z","time spent":"813.669727ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:872 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:14:12.703988Z","caller":"traceutil/trace.go:171","msg":"trace[972579818] linearizableReadLoop","detail":"{readStateIndex:912; appliedIndex:910; }","duration":"498.789355ms","start":"2026-03-20T10:14:12.205165Z","end":"2026-03-20T10:14:12.703954Z","steps":["trace[972579818] 'read index received'  (duration: 353.638017ms)","trace[972579818] 'applied index is now lower than readState.Index'  (duration: 145.149258ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:12.704064Z","caller":"traceutil/trace.go:171","msg":"trace[1439378411] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"372.227079ms","start":"2026-03-20T10:14:12.331806Z","end":"2026-03-20T10:14:12.704033Z","steps":["trace[1439378411] 'process raft request'  (duration: 371.810797ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:12.704164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.960516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:14:12.704184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.989301ms","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-20T10:14:12.704207Z","caller":"traceutil/trace.go:171","msg":"trace[1148477100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:879; }","duration":"493.024847ms","start":"2026-03-20T10:14:12.211169Z","end":"2026-03-20T10:14:12.704194Z","steps":["trace[1148477100] 'agreement among raft nodes before linearized reading'  (duration: 492.963056ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:12.704221Z","caller":"traceutil/trace.go:171","msg":"trace[1451712622] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:879; }","duration":"499.090143ms","start":"2026-03-20T10:14:12.205121Z","end":"2026-03-20T10:14:12.704211Z","steps":["trace[1451712622] 'agreement among raft nodes before linearized reading'  (duration: 498.98616ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:12.704213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:12.331784Z","time spent":"372.349072ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:798 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:12.704245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:12.211157Z","time spent":"493.082048ms","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:14:12.704259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:12.2051Z","time spent":"499.148855ms","remote":"127.0.0.1:35020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:14:12.704419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.023202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-20T10:14:12.704481Z","caller":"traceutil/trace.go:171","msg":"trace[374015769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:879; }","duration":"356.092385ms","start":"2026-03-20T10:14:12.348375Z","end":"2026-03-20T10:14:12.704467Z","steps":["trace[374015769] 'agreement among raft nodes before linearized reading'  (duration: 355.9485ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:12.704479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.161171ms","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-20T10:14:12.704506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:12.348327Z","time spent":"356.174136ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-20T10:14:12.704512Z","caller":"traceutil/trace.go:171","msg":"trace[1814872995] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:879; }","duration":"390.245013ms","start":"2026-03-20T10:14:12.314257Z","end":"2026-03-20T10:14:12.704502Z","steps":["trace[1814872995] 'agreement among raft nodes before linearized reading'  (duration: 390.12625ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:12.704539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:12.31424Z","time spent":"390.293294ms","remote":"127.0.0.1:35006","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-20T10:14:24.887384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.963106ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570119 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:907 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:24.887493Z","caller":"traceutil/trace.go:171","msg":"trace[1718339909] linearizableReadLoop","detail":"{readStateIndex:949; appliedIndex:948; }","duration":"114.29444ms","start":"2026-03-20T10:14:24.77318Z","end":"2026-03-20T10:14:24.887475Z","steps":["trace[1718339909] 'read index received'  (duration: 10.101566ms)","trace[1718339909] 'applied index is now lower than readState.Index'  (duration: 104.191484ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:24.887662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.484286ms","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-20T10:14:24.887624Z","caller":"traceutil/trace.go:171","msg":"trace[317208044] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"120.959194ms","start":"2026-03-20T10:14:24.766589Z","end":"2026-03-20T10:14:24.887549Z","steps":["trace[317208044] 'process raft request'  (duration: 16.74584ms)","trace[317208044] 'compare'  (duration: 103.520184ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:24.887688Z","caller":"traceutil/trace.go:171","msg":"trace[2055621102] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:913; }","duration":"114.535487ms","start":"2026-03-20T10:14:24.773143Z","end":"2026-03-20T10:14:24.887679Z","steps":["trace[2055621102] 'agreement among raft nodes before linearized reading'  (duration: 114.418974ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:24.887857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.164268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-20T10:14:24.887952Z","caller":"traceutil/trace.go:171","msg":"trace[103781811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:913; }","duration":"106.26779ms","start":"2026-03-20T10:14:24.781633Z","end":"2026-03-20T10:14:24.887901Z","steps":["trace[103781811] 'agreement among raft nodes before linearized reading'  (duration: 106.053805ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:27.176453Z","caller":"traceutil/trace.go:171","msg":"trace[1486367053] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"225.847145ms","start":"2026-03-20T10:14:26.950559Z","end":"2026-03-20T10:14:27.176406Z","steps":["trace[1486367053] 'process raft request'  (duration: 225.549807ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:28.473528Z","caller":"traceutil/trace.go:171","msg":"trace[580191871] linearizableReadLoop","detail":"{readStateIndex:973; appliedIndex:972; }","duration":"261.884976ms","start":"2026-03-20T10:14:28.211614Z","end":"2026-03-20T10:14:28.473499Z","steps":["trace[580191871] 'read index received'  (duration: 261.632999ms)","trace[580191871] 'applied index is now lower than readState.Index'  (duration: 251.017µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:28.473968Z","caller":"traceutil/trace.go:171","msg":"trace[620399135] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"411.535647ms","start":"2026-03-20T10:14:28.062416Z","end":"2026-03-20T10:14:28.473951Z","steps":["trace[620399135] 'process raft request'  (duration: 410.91744ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:28.474097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:28.062396Z","time spent":"411.62426ms","remote":"127.0.0.1:34900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5309,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:724 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5275 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:28.474252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.642627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:28.474308Z","caller":"traceutil/trace.go:171","msg":"trace[1429970491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:936; }","duration":"262.728628ms","start":"2026-03-20T10:14:28.211561Z","end":"2026-03-20T10:14:28.47429Z","steps":["trace[1429970491] 'agreement among raft nodes before linearized reading'  (duration: 262.656027ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:28.474627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.780685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-548lf\" ","response":"range_response_count:1 size:11057"}
{"level":"info","ts":"2026-03-20T10:14:28.474708Z","caller":"traceutil/trace.go:171","msg":"trace[1038921278] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-548lf; range_end:; response_count:1; response_revision:936; }","duration":"157.923169ms","start":"2026-03-20T10:14:28.316767Z","end":"2026-03-20T10:14:28.47469Z","steps":["trace[1038921278] 'agreement among raft nodes before linearized reading'  (duration: 157.673382ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:28.703293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.890588ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570168 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/csinodes/instance\" mod_revision:70 > success:<request_put:<key:\"/registry/csinodes/instance\" value_size:762 >> failure:<request_range:<key:\"/registry/csinodes/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:28.703376Z","caller":"traceutil/trace.go:171","msg":"trace[1815438687] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"223.309655ms","start":"2026-03-20T10:14:28.480054Z","end":"2026-03-20T10:14:28.703364Z","steps":["trace[1815438687] 'process raft request'  (duration: 61.288624ms)","trace[1815438687] 'compare'  (duration: 161.808126ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:28.783569Z","caller":"traceutil/trace.go:171","msg":"trace[2008977086] linearizableReadLoop","detail":"{readStateIndex:975; appliedIndex:974; }","duration":"145.5979ms","start":"2026-03-20T10:14:28.637912Z","end":"2026-03-20T10:14:28.78351Z","steps":["trace[2008977086] 'read index received'  (duration: 145.301502ms)","trace[2008977086] 'applied index is now lower than readState.Index'  (duration: 295.038µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:28.783689Z","caller":"traceutil/trace.go:171","msg":"trace[1951525759] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"295.572772ms","start":"2026-03-20T10:14:28.488078Z","end":"2026-03-20T10:14:28.783651Z","steps":["trace[1951525759] 'process raft request'  (duration: 295.284664ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:28.783791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.844138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:28.783877Z","caller":"traceutil/trace.go:171","msg":"trace[671609532] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:938; }","duration":"145.966791ms","start":"2026-03-20T10:14:28.637894Z","end":"2026-03-20T10:14:28.783861Z","steps":["trace[671609532] 'agreement among raft nodes before linearized reading'  (duration: 145.779055ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:29.086073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.381732ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570172 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:925 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:29.086193Z","caller":"traceutil/trace.go:171","msg":"trace[320195644] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"296.391833ms","start":"2026-03-20T10:14:28.789781Z","end":"2026-03-20T10:14:29.086173Z","steps":["trace[320195644] 'process raft request'  (duration: 105.822427ms)","trace[320195644] 'compare'  (duration: 190.232807ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:29.763554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.55991ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570173 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" mod_revision:854 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:29.763776Z","caller":"traceutil/trace.go:171","msg":"trace[428415606] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"972.967574ms","start":"2026-03-20T10:14:28.790782Z","end":"2026-03-20T10:14:29.763749Z","steps":["trace[428415606] 'process raft request'  (duration: 510.117007ms)","trace[428415606] 'compare'  (duration: 462.451726ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:29.76381Z","caller":"traceutil/trace.go:171","msg":"trace[1495563443] linearizableReadLoop","detail":"{readStateIndex:979; appliedIndex:976; }","duration":"862.496319ms","start":"2026-03-20T10:14:28.901295Z","end":"2026-03-20T10:14:29.763791Z","steps":["trace[1495563443] 'read index received'  (duration: 399.620681ms)","trace[1495563443] 'applied index is now lower than readState.Index'  (duration: 462.874718ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:29.763876Z","caller":"traceutil/trace.go:171","msg":"trace[86428270] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"972.990464ms","start":"2026-03-20T10:14:28.790855Z","end":"2026-03-20T10:14:29.763845Z","steps":["trace[86428270] 'process raft request'  (duration: 972.81452ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:29.763983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:28.790835Z","time spent":"973.096807ms","remote":"127.0.0.1:35020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1507,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-78mpd\" mod_revision:853 > success:<request_put:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-78mpd\" value_size:1420 >> failure:<request_range:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-nodeplugin-http-metrics-78mpd\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:29.763898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:28.79075Z","time spent":"973.083677ms","remote":"127.0.0.1:34884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":914,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" mod_revision:854 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:29.764104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.245883ms","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-20T10:14:29.764132Z","caller":"traceutil/trace.go:171","msg":"trace[1990776419] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:942; }","duration":"858.335374ms","start":"2026-03-20T10:14:28.90579Z","end":"2026-03-20T10:14:29.764126Z","steps":["trace[1990776419] 'agreement among raft nodes before linearized reading'  (duration: 858.223651ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:29.764152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:28.905763Z","time spent":"858.386265ms","remote":"127.0.0.1:35006","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-20T10:14:29.764176Z","caller":"traceutil/trace.go:171","msg":"trace[1112990104] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"968.677946ms","start":"2026-03-20T10:14:28.795475Z","end":"2026-03-20T10:14:29.764153Z","steps":["trace[1112990104] 'process raft request'  (duration: 968.268205ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:29.764262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.864397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-20T10:14:29.764283Z","caller":"traceutil/trace.go:171","msg":"trace[1500349485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:942; }","duration":"855.903927ms","start":"2026-03-20T10:14:28.908374Z","end":"2026-03-20T10:14:29.764278Z","steps":["trace[1500349485] 'agreement among raft nodes before linearized reading'  (duration: 855.853206ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:29.764302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:28.908363Z","time spent":"855.933708ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-20T10:14:29.764297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:28.795468Z","time spent":"968.770078ms","remote":"127.0.0.1:35178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" mod_revision:842 > success:<request_put:<key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" value_size:9311 >> failure:<request_range:<key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:29.764083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.772446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T10:14:29.764561Z","caller":"traceutil/trace.go:171","msg":"trace[331551102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:942; }","duration":"863.29685ms","start":"2026-03-20T10:14:28.901253Z","end":"2026-03-20T10:14:29.764549Z","steps":["trace[331551102] 'agreement among raft nodes before linearized reading'  (duration: 862.665113ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:29.7646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:28.901236Z","time spent":"863.351782ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-20T10:14:30.512654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.687548ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570178 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:926 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:30.512872Z","caller":"traceutil/trace.go:171","msg":"trace[462485198] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"741.834563ms","start":"2026-03-20T10:14:29.771007Z","end":"2026-03-20T10:14:30.512842Z","steps":["trace[462485198] 'process raft request'  (duration: 153.858968ms)","trace[462485198] 'compare'  (duration: 587.509523ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:30.512924Z","caller":"traceutil/trace.go:171","msg":"trace[2143902812] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:979; }","duration":"454.900889ms","start":"2026-03-20T10:14:30.058005Z","end":"2026-03-20T10:14:30.512906Z","steps":["trace[2143902812] 'read index received'  (duration: 340.32905ms)","trace[2143902812] 'applied index is now lower than readState.Index'  (duration: 114.570729ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:30.512973Z","caller":"traceutil/trace.go:171","msg":"trace[1584222858] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"741.904265ms","start":"2026-03-20T10:14:29.771049Z","end":"2026-03-20T10:14:30.512953Z","steps":["trace[1584222858] 'process raft request'  (duration: 741.720041ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:30.513006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:29.770992Z","time spent":"741.947206ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:926 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:14:30.513017Z","caller":"traceutil/trace.go:171","msg":"trace[1682162640] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"741.892465ms","start":"2026-03-20T10:14:29.771114Z","end":"2026-03-20T10:14:30.513006Z","steps":["trace[1682162640] 'process raft request'  (duration: 741.756782ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:30.513061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:29.771017Z","time spent":"742.002958ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:927 > 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-20T10:14:30.513077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:29.771105Z","time spent":"741.939596ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:928 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:30.513241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.702801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:30.513276Z","caller":"traceutil/trace.go:171","msg":"trace[119854434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:945; }","duration":"301.772701ms","start":"2026-03-20T10:14:30.211495Z","end":"2026-03-20T10:14:30.513268Z","steps":["trace[119854434] 'agreement among raft nodes before linearized reading'  (duration: 301.71897ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:30.513299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:30.211476Z","time spent":"301.817723ms","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:14:30.513315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.321181ms","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-20T10:14:30.513347Z","caller":"traceutil/trace.go:171","msg":"trace[2088807999] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:945; }","duration":"455.388993ms","start":"2026-03-20T10:14:30.057947Z","end":"2026-03-20T10:14:30.513336Z","steps":["trace[2088807999] 'agreement among raft nodes before linearized reading'  (duration: 455.27691ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:30.513375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:30.057925Z","time spent":"455.444104ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-20T10:14:30.513368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.056153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"}
{"level":"warn","ts":"2026-03-20T10:14:30.513956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.68283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:30.514226Z","caller":"traceutil/trace.go:171","msg":"trace[2007551916] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:945; }","duration":"380.242658ms","start":"2026-03-20T10:14:30.133281Z","end":"2026-03-20T10:14:30.513524Z","steps":["trace[2007551916] 'agreement among raft nodes before linearized reading'  (duration: 379.99321ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:30.514381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:30.13327Z","time spent":"381.06255ms","remote":"127.0.0.1:34728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.22\" "}
{"level":"info","ts":"2026-03-20T10:14:30.514418Z","caller":"traceutil/trace.go:171","msg":"trace[60604071] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:945; }","duration":"412.880854ms","start":"2026-03-20T10:14:30.10117Z","end":"2026-03-20T10:14:30.514051Z","steps":["trace[60604071] 'agreement among raft nodes before linearized reading'  (duration: 412.639067ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:30.514459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:30.101145Z","time spent":"413.301066ms","remote":"127.0.0.1:34870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:14:31.322006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.8314ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570185 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:0e099d0abb64dc48>","response":"size:40"}
{"level":"warn","ts":"2026-03-20T10:14:31.322113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:30.51638Z","time spent":"805.728829ms","remote":"127.0.0.1:34728","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-20T10:14:31.886421Z","caller":"traceutil/trace.go:171","msg":"trace[1230721269] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:982; }","duration":"795.59187ms","start":"2026-03-20T10:14:31.090798Z","end":"2026-03-20T10:14:31.88639Z","steps":["trace[1230721269] 'read index received'  (duration: 23.354572ms)","trace[1230721269] 'applied index is now lower than readState.Index'  (duration: 772.236158ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:31.886826Z","caller":"traceutil/trace.go:171","msg":"trace[1264333318] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"1.369029177s","start":"2026-03-20T10:14:30.517785Z","end":"2026-03-20T10:14:31.886814Z","steps":["trace[1264333318] 'process raft request'  (duration: 1.368426801s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:31.88693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:30.517764Z","time spent":"1.369093519s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:935 > 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-20T10:14:31.887259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.471674ms","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-20T10:14:31.887304Z","caller":"traceutil/trace.go:171","msg":"trace[440529155] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:946; }","duration":"796.577638ms","start":"2026-03-20T10:14:31.090715Z","end":"2026-03-20T10:14:31.887293Z","steps":["trace[440529155] 'agreement among raft nodes before linearized reading'  (duration: 796.441873ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:31.887336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:31.090684Z","time spent":"796.644699ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-20T10:14:32.10177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.843782ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570187 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.22\" mod_revision:899 > success:<request_put:<key:\"/registry/masterleases/199.204.45.22\" value_size:66 lease:1011512260740570184 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.22\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:32.10192Z","caller":"traceutil/trace.go:171","msg":"trace[251669576] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"210.284919ms","start":"2026-03-20T10:14:31.891619Z","end":"2026-03-20T10:14:32.101904Z","steps":["trace[251669576] 'process raft request'  (duration: 210.235967ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:32.10194Z","caller":"traceutil/trace.go:171","msg":"trace[1080063521] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"778.843431ms","start":"2026-03-20T10:14:31.323048Z","end":"2026-03-20T10:14:32.101892Z","steps":["trace[1080063521] 'process raft request'  (duration: 626.823434ms)","trace[1080063521] 'compare'  (duration: 151.74933ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:32.102054Z","caller":"traceutil/trace.go:171","msg":"trace[1381830987] linearizableReadLoop","detail":"{readStateIndex:985; appliedIndex:984; }","duration":"215.520942ms","start":"2026-03-20T10:14:31.886527Z","end":"2026-03-20T10:14:32.102048Z","steps":["trace[1381830987] 'read index received'  (duration: 63.33877ms)","trace[1381830987] 'applied index is now lower than readState.Index'  (duration: 152.179591ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:32.102099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.859431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:32.102112Z","caller":"traceutil/trace.go:171","msg":"trace[1633558392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:948; }","duration":"889.939923ms","start":"2026-03-20T10:14:31.212167Z","end":"2026-03-20T10:14:32.102107Z","steps":["trace[1633558392] 'agreement among raft nodes before linearized reading'  (duration: 889.902752ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:32.102126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:31.212138Z","time spent":"889.984264ms","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:14:32.102166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:31.323023Z","time spent":"779.033826ms","remote":"127.0.0.1:34728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.22\" mod_revision:899 > success:<request_put:<key:\"/registry/masterleases/199.204.45.22\" value_size:66 lease:1011512260740570184 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.22\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:32.507792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.636804ms","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-20T10:14:32.507881Z","caller":"traceutil/trace.go:171","msg":"trace[1026716480] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:948; }","duration":"128.786019ms","start":"2026-03-20T10:14:32.379078Z","end":"2026-03-20T10:14:32.507864Z","steps":["trace[1026716480] 'count revisions from in-memory index tree'  (duration: 128.562972ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:32.721775Z","caller":"traceutil/trace.go:171","msg":"trace[1109919383] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"200.52378ms","start":"2026-03-20T10:14:32.521227Z","end":"2026-03-20T10:14:32.721751Z","steps":["trace[1109919383] 'process raft request'  (duration: 200.403246ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:32.799905Z","caller":"traceutil/trace.go:171","msg":"trace[528646976] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"278.129091ms","start":"2026-03-20T10:14:32.521729Z","end":"2026-03-20T10:14:32.799858Z","steps":["trace[528646976] 'process raft request'  (duration: 277.699249ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:32.801787Z","caller":"traceutil/trace.go:171","msg":"trace[1107077178] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"278.667828ms","start":"2026-03-20T10:14:32.523076Z","end":"2026-03-20T10:14:32.801744Z","steps":["trace[1107077178] 'process raft request'  (duration: 276.500608ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:33.168566Z","caller":"traceutil/trace.go:171","msg":"trace[251233529] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"221.020163ms","start":"2026-03-20T10:14:32.94752Z","end":"2026-03-20T10:14:33.168541Z","steps":["trace[251233529] 'process raft request'  (duration: 220.883599ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:33.420559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.378076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:33.420692Z","caller":"traceutil/trace.go:171","msg":"trace[121062198] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:952; }","duration":"208.561891ms","start":"2026-03-20T10:14:33.212101Z","end":"2026-03-20T10:14:33.420663Z","steps":["trace[121062198] 'range keys from in-memory index tree'  (duration: 208.20657ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:33.42073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.961399ms","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":"info","ts":"2026-03-20T10:14:33.420853Z","caller":"traceutil/trace.go:171","msg":"trace[458728417] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:952; }","duration":"218.175544ms","start":"2026-03-20T10:14:33.202652Z","end":"2026-03-20T10:14:33.420827Z","steps":["trace[458728417] 'count revisions from in-memory index tree'  (duration: 217.800235ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:33.420926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.91861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T10:14:33.421025Z","caller":"traceutil/trace.go:171","msg":"trace[1423476079] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:952; }","duration":"217.078145ms","start":"2026-03-20T10:14:33.203925Z","end":"2026-03-20T10:14:33.421003Z","steps":["trace[1423476079] 'count revisions from in-memory index tree'  (duration: 216.746056ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:34.392051Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512260740570206,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:14:34.892716Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512260740570206,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:14:35.176706Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.56390971s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T10:14:35.177519Z","caller":"traceutil/trace.go:171","msg":"trace[1489300512] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"1.564805956s","start":"2026-03-20T10:14:33.612684Z","end":"2026-03-20T10:14:35.17749Z","steps":["trace[1489300512] 'process raft request'  (duration: 1.564353033s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:35.177723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:33.612663Z","time spent":"1.56495346s","remote":"127.0.0.1:34788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":891,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-j5tn9.189e851f8270a5d5\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-j5tn9.189e851f8270a5d5\" value_size:787 lease:1011512260740569931 >> failure:<>"}
{"level":"warn","ts":"2026-03-20T10:14:36.212167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99985117s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-20T10:14:36.212265Z","caller":"traceutil/trace.go:171","msg":"trace[1068379571] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000003563s","start":"2026-03-20T10:14:34.212239Z","end":"2026-03-20T10:14:36.212242Z","steps":["trace[1068379571] 'agreement among raft nodes before linearized reading'  (duration: 1.999889s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:36.212313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:34.212216Z","time spent":"2.000086366s","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/20 10:14:36 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-20T10:14:36.275524Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.098543705s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T10:14:36.276016Z","caller":"traceutil/trace.go:171","msg":"trace[570646793] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"1.986235964s","start":"2026-03-20T10:14:34.289754Z","end":"2026-03-20T10:14:36.27599Z","steps":["trace[570646793] 'process raft request'  (duration: 1.986019348s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:36.276169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:34.289731Z","time spent":"1.986360298s","remote":"127.0.0.1:34900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5735,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:936 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5701 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-20T10:14:36.276348Z","caller":"traceutil/trace.go:171","msg":"trace[663711885] linearizableReadLoop","detail":"{readStateIndex:993; appliedIndex:990; }","duration":"2.384924719s","start":"2026-03-20T10:14:33.891382Z","end":"2026-03-20T10:14:36.276306Z","steps":["trace[663711885] 'read index received'  (duration: 1.285617534s)","trace[663711885] 'applied index is now lower than readState.Index'  (duration: 1.099306105s)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:36.276592Z","caller":"traceutil/trace.go:171","msg":"trace[1515825838] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"1.799392981s","start":"2026-03-20T10:14:34.477189Z","end":"2026-03-20T10:14:36.276582Z","steps":["trace[1515825838] 'process raft request'  (duration: 1.798747193s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:36.276659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:34.477145Z","time spent":"1.799479083s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:911 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:36.276782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.385388121s","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-20T10:14:36.276867Z","caller":"traceutil/trace.go:171","msg":"trace[829377621] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:955; }","duration":"2.385523036s","start":"2026-03-20T10:14:33.891323Z","end":"2026-03-20T10:14:36.276846Z","steps":["trace[829377621] 'agreement among raft nodes before linearized reading'  (duration: 2.38532113s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:36.276923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:33.891296Z","time spent":"2.385617849s","remote":"127.0.0.1:35006","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-20T10:14:36.780127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.839549ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570210 > lease_revoke:<id:0e099d0abb64dbdd>","response":"size:28"}
{"level":"info","ts":"2026-03-20T10:14:36.780288Z","caller":"traceutil/trace.go:171","msg":"trace[927235866] linearizableReadLoop","detail":"{readStateIndex:994; appliedIndex:993; }","duration":"503.880613ms","start":"2026-03-20T10:14:36.276382Z","end":"2026-03-20T10:14:36.780262Z","steps":["trace[927235866] 'read index received'  (duration: 124.995053ms)","trace[927235866] 'applied index is now lower than readState.Index'  (duration: 378.8833ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:36.780568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.974754499s","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-20T10:14:36.780522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.933266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:14:36.780622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.163223281s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:14:36.78067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.976887417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T10:14:36.780671Z","caller":"traceutil/trace.go:171","msg":"trace[1483882075] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:955; }","duration":"1.974958944s","start":"2026-03-20T10:14:34.80569Z","end":"2026-03-20T10:14:36.780649Z","steps":["trace[1483882075] 'agreement among raft nodes before linearized reading'  (duration: 1.974622525s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:36.780704Z","caller":"traceutil/trace.go:171","msg":"trace[813468737] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:955; }","duration":"1.163374475s","start":"2026-03-20T10:14:35.617303Z","end":"2026-03-20T10:14:36.780677Z","steps":["trace[813468737] 'agreement among raft nodes before linearized reading'  (duration: 1.163144599s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:36.780701Z","caller":"traceutil/trace.go:171","msg":"trace[1642955276] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:955; }","duration":"567.159683ms","start":"2026-03-20T10:14:36.21351Z","end":"2026-03-20T10:14:36.78067Z","steps":["trace[1642955276] 'agreement among raft nodes before linearized reading'  (duration: 566.919346ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:36.780731Z","caller":"traceutil/trace.go:171","msg":"trace[266028251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:955; }","duration":"1.976993881s","start":"2026-03-20T10:14:34.803722Z","end":"2026-03-20T10:14:36.780716Z","steps":["trace[266028251] 'agreement among raft nodes before linearized reading'  (duration: 1.976674373s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:36.78074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:34.80567Z","time spent":"1.975059988s","remote":"127.0.0.1:35006","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-20T10:14:36.780772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:34.803699Z","time spent":"1.977063642s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-20T10:14:36.780767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:35.617247Z","time spent":"1.163503139s","remote":"127.0.0.1:35126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:14:36.780777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:36.213487Z","time spent":"567.270096ms","remote":"127.0.0.1:34710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:14:36.780779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.673480248s","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":"warn","ts":"2026-03-20T10:14:36.780823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.054622303s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-20T10:14:36.780838Z","caller":"traceutil/trace.go:171","msg":"trace[1924946608] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:955; }","duration":"2.67357519s","start":"2026-03-20T10:14:34.107247Z","end":"2026-03-20T10:14:36.780822Z","steps":["trace[1924946608] 'agreement among raft nodes before linearized reading'  (duration: 2.673156019s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:36.780865Z","caller":"traceutil/trace.go:171","msg":"trace[1221542758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:955; }","duration":"2.054667225s","start":"2026-03-20T10:14:34.726187Z","end":"2026-03-20T10:14:36.780854Z","steps":["trace[1221542758] 'agreement among raft nodes before linearized reading'  (duration: 2.05413433s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:36.780878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:34.107225Z","time spent":"2.673642512s","remote":"127.0.0.1:35006","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-20T10:14:36.780909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:34.726125Z","time spent":"2.054760987s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-20T10:14:36.781326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.168928763s","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-20T10:14:36.781379Z","caller":"traceutil/trace.go:171","msg":"trace[813300049] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:955; }","duration":"2.169025507s","start":"2026-03-20T10:14:34.612338Z","end":"2026-03-20T10:14:36.781364Z","steps":["trace[813300049] 'agreement among raft nodes before linearized reading'  (duration: 2.168019389s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:36.781423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:34.612316Z","time spent":"2.169094079s","remote":"127.0.0.1:34974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:14:36.80955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.126736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:36.809751Z","caller":"traceutil/trace.go:171","msg":"trace[1702922136] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:956; }","duration":"522.573668ms","start":"2026-03-20T10:14:36.287154Z","end":"2026-03-20T10:14:36.809727Z","steps":["trace[1702922136] 'agreement among raft nodes before linearized reading'  (duration: 522.114666ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:36.809612Z","caller":"traceutil/trace.go:171","msg":"trace[2094067253] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"526.857066ms","start":"2026-03-20T10:14:36.282693Z","end":"2026-03-20T10:14:36.80955Z","steps":["trace[2094067253] 'process raft request'  (duration: 526.282491ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:36.809881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:36.287136Z","time spent":"522.730173ms","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:14:36.80996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:36.282661Z","time spent":"527.187505ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:946 > 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-20T10:14:37.287285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.193929ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570215 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189e85203f9bafa3\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189e85203f9bafa3\" value_size:672 lease:1011512260740569931 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:37.287799Z","caller":"traceutil/trace.go:171","msg":"trace[1588683449] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"500.121732ms","start":"2026-03-20T10:14:36.787651Z","end":"2026-03-20T10:14:37.287773Z","steps":["trace[1588683449] 'process raft request'  (duration: 500.032549ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:37.287855Z","caller":"traceutil/trace.go:171","msg":"trace[1924378527] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"501.938821ms","start":"2026-03-20T10:14:36.785879Z","end":"2026-03-20T10:14:37.287817Z","steps":["trace[1924378527] 'process raft request'  (duration: 122.106415ms)","trace[1924378527] 'compare'  (duration: 378.917392ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:37.287926Z","caller":"traceutil/trace.go:171","msg":"trace[1309559532] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"501.85991ms","start":"2026-03-20T10:14:36.786043Z","end":"2026-03-20T10:14:37.287903Z","steps":["trace[1309559532] 'process raft request'  (duration: 501.47662ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:37.287942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:36.787638Z","time spent":"500.229985ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:951 > 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-20T10:14:37.287998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:36.78585Z","time spent":"502.082606ms","remote":"127.0.0.1:34788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189e85203f9bafa3\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189e85203f9bafa3\" value_size:672 lease:1011512260740569931 >> failure:<>"}
{"level":"warn","ts":"2026-03-20T10:14:37.288035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:36.786015Z","time spent":"501.961552ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:948 > 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-20T10:14:37.28815Z","caller":"traceutil/trace.go:171","msg":"trace[1219028486] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"502.26089ms","start":"2026-03-20T10:14:36.785879Z","end":"2026-03-20T10:14:37.288139Z","steps":["trace[1219028486] 'process raft request'  (duration: 501.52449ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:37.288256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:36.78585Z","time spent":"502.333283ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:950 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:14:37.289284Z","caller":"traceutil/trace.go:171","msg":"trace[1452222604] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"501.87066ms","start":"2026-03-20T10:14:36.785906Z","end":"2026-03-20T10:14:37.287776Z","steps":["trace[1452222604] 'process raft request'  (duration: 501.573371ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:37.290203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:36.785872Z","time spent":"504.203105ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:949 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:14:37.615755Z","caller":"traceutil/trace.go:171","msg":"trace[1838949647] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1000; }","duration":"134.604799ms","start":"2026-03-20T10:14:37.481111Z","end":"2026-03-20T10:14:37.615716Z","steps":["trace[1838949647] 'read index received'  (duration: 114.758783ms)","trace[1838949647] 'applied index is now lower than readState.Index'  (duration: 19.843705ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:37.615788Z","caller":"traceutil/trace.go:171","msg":"trace[1043423515] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"319.54467ms","start":"2026-03-20T10:14:37.296211Z","end":"2026-03-20T10:14:37.615755Z","steps":["trace[1043423515] 'process raft request'  (duration: 299.684025ms)","trace[1043423515] 'compare'  (duration: 19.412863ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:37.615971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.825784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:37.616171Z","caller":"traceutil/trace.go:171","msg":"trace[1826029263] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:962; }","duration":"135.104521ms","start":"2026-03-20T10:14:37.481045Z","end":"2026-03-20T10:14:37.61615Z","steps":["trace[1826029263] 'agreement among raft nodes before linearized reading'  (duration: 134.797523ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:37.615993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:37.2962Z","time spent":"319.674333ms","remote":"127.0.0.1:34788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189e85203f9bafa3\" mod_revision:957 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189e85203f9bafa3\" value_size:672 lease:1011512260740569931 >> failure:<request_range:<key:\"/registry/events/kube-system/kube-apiserver-instance.189e85203f9bafa3\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:38.953616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.61228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:38.95371Z","caller":"traceutil/trace.go:171","msg":"trace[874504680] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:962; }","duration":"740.767034ms","start":"2026-03-20T10:14:38.212922Z","end":"2026-03-20T10:14:38.953689Z","steps":["trace[874504680] 'range keys from in-memory index tree'  (duration: 740.524657ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:38.95375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:38.212895Z","time spent":"740.845806ms","remote":"127.0.0.1:34710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:14:38.95408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.441611ms","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-20T10:14:38.954121Z","caller":"traceutil/trace.go:171","msg":"trace[1627274584] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:962; }","duration":"139.535835ms","start":"2026-03-20T10:14:38.814573Z","end":"2026-03-20T10:14:38.954109Z","steps":["trace[1627274584] 'range keys from in-memory index tree'  (duration: 139.224086ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:39.450789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.087681ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570227 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-j5tn9.189e8520c6187310\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-j5tn9.189e8520c6187310\" value_size:683 lease:1011512260740569931 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:39.451827Z","caller":"traceutil/trace.go:171","msg":"trace[470529127] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1002; }","duration":"308.404514ms","start":"2026-03-20T10:14:39.143391Z","end":"2026-03-20T10:14:39.451795Z","steps":["trace[470529127] 'read index received'  (duration: 156.11069ms)","trace[470529127] 'applied index is now lower than readState.Index'  (duration: 152.291484ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:39.45196Z","caller":"traceutil/trace.go:171","msg":"trace[1563991655] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"409.674796ms","start":"2026-03-20T10:14:39.042247Z","end":"2026-03-20T10:14:39.451921Z","steps":["trace[1563991655] 'process raft request'  (duration: 257.214207ms)","trace[1563991655] 'compare'  (duration: 150.798854ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:39.452072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.681852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:14:39.452118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:39.042215Z","time spent":"409.828991ms","remote":"127.0.0.1:34788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":787,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-j5tn9.189e8520c6187310\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-j5tn9.189e8520c6187310\" value_size:683 lease:1011512260740569931 >> failure:<>"}
{"level":"info","ts":"2026-03-20T10:14:39.452147Z","caller":"traceutil/trace.go:171","msg":"trace[583998702] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:964; }","duration":"308.773624ms","start":"2026-03-20T10:14:39.143359Z","end":"2026-03-20T10:14:39.452132Z","steps":["trace[583998702] 'agreement among raft nodes before linearized reading'  (duration: 308.592959ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:39.452223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:39.143271Z","time spent":"308.936859ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-20T10:14:39.45275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.254598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-20T10:14:39.452803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.021661ms","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-20T10:14:39.45281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.014272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:39.452856Z","caller":"traceutil/trace.go:171","msg":"trace[1499549947] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:964; }","duration":"158.125665ms","start":"2026-03-20T10:14:39.294719Z","end":"2026-03-20T10:14:39.452845Z","steps":["trace[1499549947] 'agreement among raft nodes before linearized reading'  (duration: 157.97454ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:39.452857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.985524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-20T10:14:39.452865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.551117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-20T10:14:39.452879Z","caller":"traceutil/trace.go:171","msg":"trace[147125778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:964; }","duration":"241.109426ms","start":"2026-03-20T10:14:39.211753Z","end":"2026-03-20T10:14:39.452863Z","steps":["trace[147125778] 'agreement among raft nodes before linearized reading'  (duration: 241.004333ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:39.452907Z","caller":"traceutil/trace.go:171","msg":"trace[363445867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:964; }","duration":"157.105047ms","start":"2026-03-20T10:14:39.295789Z","end":"2026-03-20T10:14:39.452894Z","steps":["trace[363445867] 'agreement among raft nodes before linearized reading'  (duration: 156.925892ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:39.452914Z","caller":"traceutil/trace.go:171","msg":"trace[546047028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:964; }","duration":"158.659569ms","start":"2026-03-20T10:14:39.294242Z","end":"2026-03-20T10:14:39.452902Z","steps":["trace[546047028] 'agreement among raft nodes before linearized reading'  (duration: 158.497285ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:39.452906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.526329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-20T10:14:39.452944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.31993ms","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-20T10:14:39.452813Z","caller":"traceutil/trace.go:171","msg":"trace[43659739] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:964; }","duration":"293.373221ms","start":"2026-03-20T10:14:39.159423Z","end":"2026-03-20T10:14:39.452796Z","steps":["trace[43659739] 'agreement among raft nodes before linearized reading'  (duration: 293.226668ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:39.453Z","caller":"traceutil/trace.go:171","msg":"trace[7343977] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:964; }","duration":"248.664153ms","start":"2026-03-20T10:14:39.204316Z","end":"2026-03-20T10:14:39.45298Z","steps":["trace[7343977] 'agreement among raft nodes before linearized reading'  (duration: 248.495018ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:39.452994Z","caller":"traceutil/trace.go:171","msg":"trace[186159269] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:964; }","duration":"158.382092ms","start":"2026-03-20T10:14:39.294603Z","end":"2026-03-20T10:14:39.452985Z","steps":["trace[186159269] 'agreement among raft nodes before linearized reading'  (duration: 158.241998ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:39.453262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.876606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T10:14:39.453307Z","caller":"traceutil/trace.go:171","msg":"trace[1581722047] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:964; }","duration":"130.945529ms","start":"2026-03-20T10:14:39.322352Z","end":"2026-03-20T10:14:39.453297Z","steps":["trace[1581722047] 'agreement among raft nodes before linearized reading'  (duration: 130.873676ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:39.868053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.820799ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570231 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:958 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:39.868318Z","caller":"traceutil/trace.go:171","msg":"trace[32082787] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"410.802628ms","start":"2026-03-20T10:14:39.457475Z","end":"2026-03-20T10:14:39.868277Z","steps":["trace[32082787] 'process raft request'  (duration: 98.500576ms)","trace[32082787] 'compare'  (duration: 311.678154ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:39.86851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:39.457454Z","time spent":"410.955762ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:958 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:14:39.868835Z","caller":"traceutil/trace.go:171","msg":"trace[2118128288] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"411.324642ms","start":"2026-03-20T10:14:39.457488Z","end":"2026-03-20T10:14:39.868812Z","steps":["trace[2118128288] 'process raft request'  (duration: 411.222549ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:39.868935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:39.457478Z","time spent":"411.411505ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:961 > 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-20T10:14:39.963801Z","caller":"traceutil/trace.go:171","msg":"trace[1816960995] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"506.095716ms","start":"2026-03-20T10:14:39.457676Z","end":"2026-03-20T10:14:39.963771Z","steps":["trace[1816960995] 'process raft request'  (duration: 505.89848ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:39.963991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:39.457654Z","time spent":"506.23413ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:960 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:14:39.964148Z","caller":"traceutil/trace.go:171","msg":"trace[43185322] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1003; }","duration":"502.269731ms","start":"2026-03-20T10:14:39.461839Z","end":"2026-03-20T10:14:39.964109Z","steps":["trace[43185322] 'read index received'  (duration: 94.155307ms)","trace[43185322] 'applied index is now lower than readState.Index'  (duration: 408.111484ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:39.964242Z","caller":"traceutil/trace.go:171","msg":"trace[276357318] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"505.717176ms","start":"2026-03-20T10:14:39.4585Z","end":"2026-03-20T10:14:39.964217Z","steps":["trace[276357318] 'process raft request'  (duration: 505.228412ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:39.96436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:39.458454Z","time spent":"505.850669ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:959 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:39.964441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.559889ms","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-20T10:14:39.964676Z","caller":"traceutil/trace.go:171","msg":"trace[1667709014] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:968; }","duration":"502.790436ms","start":"2026-03-20T10:14:39.461814Z","end":"2026-03-20T10:14:39.964604Z","steps":["trace[1667709014] 'agreement among raft nodes before linearized reading'  (duration: 502.496088ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:39.964794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:39.461805Z","time spent":"502.9702ms","remote":"127.0.0.1:34796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"warn","ts":"2026-03-20T10:14:40.112034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.896001ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570235 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-j5tn9.189e8520e84bf3ae\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-j5tn9.189e8520e84bf3ae\" value_size:683 lease:1011512260740569931 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:40.11217Z","caller":"traceutil/trace.go:171","msg":"trace[2020204478] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"494.471617ms","start":"2026-03-20T10:14:39.617668Z","end":"2026-03-20T10:14:40.112139Z","steps":["trace[2020204478] 'process raft request'  (duration: 384.396981ms)","trace[2020204478] 'compare'  (duration: 109.346656ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:40.112296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:39.617641Z","time spent":"494.60367ms","remote":"127.0.0.1:34788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":787,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-j5tn9.189e8520e84bf3ae\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-j5tn9.189e8520e84bf3ae\" value_size:683 lease:1011512260740569931 >> failure:<>"}
{"level":"info","ts":"2026-03-20T10:14:40.112285Z","caller":"traceutil/trace.go:171","msg":"trace[1482435104] linearizableReadLoop","detail":"{readStateIndex:1008; appliedIndex:1007; }","duration":"147.976046ms","start":"2026-03-20T10:14:39.964255Z","end":"2026-03-20T10:14:40.112231Z","steps":["trace[1482435104] 'read index received'  (duration: 37.82281ms)","trace[1482435104] 'applied index is now lower than readState.Index'  (duration: 110.143915ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:40.112576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.531731ms","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-20T10:14:40.112601Z","caller":"traceutil/trace.go:171","msg":"trace[821094443] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"144.957653ms","start":"2026-03-20T10:14:39.967632Z","end":"2026-03-20T10:14:40.112589Z","steps":["trace[821094443] 'process raft request'  (duration: 144.49502ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:40.112631Z","caller":"traceutil/trace.go:171","msg":"trace[709440973] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:969; }","duration":"243.675105ms","start":"2026-03-20T10:14:39.868937Z","end":"2026-03-20T10:14:40.112612Z","steps":["trace[709440973] 'agreement among raft nodes before linearized reading'  (duration: 243.449929ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:40.596878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.6112ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570242 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:970 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:404 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:40.597133Z","caller":"traceutil/trace.go:171","msg":"trace[1704556576] linearizableReadLoop","detail":"{readStateIndex:1013; appliedIndex:1011; }","duration":"384.568118ms","start":"2026-03-20T10:14:40.212545Z","end":"2026-03-20T10:14:40.597113Z","steps":["trace[1704556576] 'read index received'  (duration: 71.601048ms)","trace[1704556576] 'applied index is now lower than readState.Index'  (duration: 312.96608ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:40.59734Z","caller":"traceutil/trace.go:171","msg":"trace[166001459] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"455.192707ms","start":"2026-03-20T10:14:40.142131Z","end":"2026-03-20T10:14:40.597324Z","steps":["trace[166001459] 'process raft request'  (duration: 142.046093ms)","trace[166001459] 'compare'  (duration: 312.481676ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:40.597409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:40.142111Z","time spent":"455.262679ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:970 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:404 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:40.597928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:40.194896Z","time spent":"403.029894ms","remote":"127.0.0.1:34728","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-20T10:14:40.598169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.621705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:40.598215Z","caller":"traceutil/trace.go:171","msg":"trace[362229351] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:973; }","duration":"385.702608ms","start":"2026-03-20T10:14:40.212496Z","end":"2026-03-20T10:14:40.598198Z","steps":["trace[362229351] 'agreement among raft nodes before linearized reading'  (duration: 385.632846ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:40.59825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:40.212477Z","time spent":"385.76503ms","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:14:41.111475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.001493ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570248 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.22\" mod_revision:947 > success:<request_put:<key:\"/registry/masterleases/199.204.45.22\" value_size:66 lease:1011512260740570244 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.22\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:41.111582Z","caller":"traceutil/trace.go:171","msg":"trace[1827332804] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1013; }","duration":"511.443643ms","start":"2026-03-20T10:14:40.600121Z","end":"2026-03-20T10:14:41.111565Z","steps":["trace[1827332804] 'read index received'  (duration: 116.353707ms)","trace[1827332804] 'applied index is now lower than readState.Index'  (duration: 395.088806ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:41.111678Z","caller":"traceutil/trace.go:171","msg":"trace[1530481232] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"511.790703ms","start":"2026-03-20T10:14:40.599873Z","end":"2026-03-20T10:14:41.111664Z","steps":["trace[1530481232] 'process raft request'  (duration: 116.514271ms)","trace[1530481232] 'compare'  (duration: 394.84973ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:41.111741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:40.599841Z","time spent":"511.865854ms","remote":"127.0.0.1:34728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.22\" mod_revision:947 > success:<request_put:<key:\"/registry/masterleases/199.204.45.22\" value_size:66 lease:1011512260740570244 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.22\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:41.112062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.920875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:41.112143Z","caller":"traceutil/trace.go:171","msg":"trace[1818132451] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:974; }","duration":"512.05791ms","start":"2026-03-20T10:14:40.600068Z","end":"2026-03-20T10:14:41.112126Z","steps":["trace[1818132451] 'agreement among raft nodes before linearized reading'  (duration: 511.882315ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:41.112183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:40.600044Z","time spent":"512.131521ms","remote":"127.0.0.1:34710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:14:41.113092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.384028ms","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-20T10:14:41.113204Z","caller":"traceutil/trace.go:171","msg":"trace[2041641861] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:974; }","duration":"136.543822ms","start":"2026-03-20T10:14:40.976638Z","end":"2026-03-20T10:14:41.113182Z","steps":["trace[2041641861] 'agreement among raft nodes before linearized reading'  (duration: 135.229305ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:41.880636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.666314ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740570254 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:963 > 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-20T10:14:41.880831Z","caller":"traceutil/trace.go:171","msg":"trace[728286454] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"762.146351ms","start":"2026-03-20T10:14:41.11866Z","end":"2026-03-20T10:14:41.880806Z","steps":["trace[728286454] 'process raft request'  (duration: 137.214ms)","trace[728286454] 'compare'  (duration: 624.555661ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:41.881733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:41.118646Z","time spent":"762.47479ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:963 > 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-20T10:14:42.049087Z","caller":"traceutil/trace.go:171","msg":"trace[1587391438] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"164.230013ms","start":"2026-03-20T10:14:41.884814Z","end":"2026-03-20T10:14:42.049044Z","steps":["trace[1587391438] 'process raft request'  (duration: 159.200605ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:43.308898Z","caller":"traceutil/trace.go:171","msg":"trace[425777281] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"103.112004ms","start":"2026-03-20T10:14:43.205765Z","end":"2026-03-20T10:14:43.308877Z","steps":["trace[425777281] 'process raft request'  (duration: 102.984221ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:44.2436Z","caller":"traceutil/trace.go:171","msg":"trace[563708759] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1029; }","duration":"169.181368ms","start":"2026-03-20T10:14:44.074398Z","end":"2026-03-20T10:14:44.243579Z","steps":["trace[563708759] 'read index received'  (duration: 168.222972ms)","trace[563708759] 'applied index is now lower than readState.Index'  (duration: 957.406µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:44.243695Z","caller":"traceutil/trace.go:171","msg":"trace[408507921] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"185.311152ms","start":"2026-03-20T10:14:44.058359Z","end":"2026-03-20T10:14:44.24367Z","steps":["trace[408507921] 'process raft request'  (duration: 184.334935ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.243836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.404791ms","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-20T10:14:44.243872Z","caller":"traceutil/trace.go:171","msg":"trace[268754416] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:990; }","duration":"147.490383ms","start":"2026-03-20T10:14:44.096371Z","end":"2026-03-20T10:14:44.243861Z","steps":["trace[268754416] 'agreement among raft nodes before linearized reading'  (duration: 147.335678ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.243842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.428775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-20T10:14:44.243928Z","caller":"traceutil/trace.go:171","msg":"trace[1667694654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:990; }","duration":"169.559078ms","start":"2026-03-20T10:14:44.074346Z","end":"2026-03-20T10:14:44.243905Z","steps":["trace[1667694654] 'agreement among raft nodes before linearized reading'  (duration: 169.332282ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:45.770208Z","caller":"traceutil/trace.go:171","msg":"trace[1091287214] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"160.608372ms","start":"2026-03-20T10:14:45.609575Z","end":"2026-03-20T10:14:45.770183Z","steps":["trace[1091287214] 'process raft request'  (duration: 160.465448ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:04.586176Z","caller":"traceutil/trace.go:171","msg":"trace[709165487] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"182.207707ms","start":"2026-03-20T10:16:04.403935Z","end":"2026-03-20T10:16:04.586143Z","steps":["trace[709165487] 'process raft request'  (duration: 92.200248ms)","trace[709165487] 'compare'  (duration: 89.868466ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:16:10.841745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.819306ms","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-20T10:16:10.841788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.508508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T10:16:10.841845Z","caller":"traceutil/trace.go:171","msg":"trace[2046054290] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1364; }","duration":"101.591789ms","start":"2026-03-20T10:16:10.74024Z","end":"2026-03-20T10:16:10.841832Z","steps":["trace[2046054290] 'count revisions from in-memory index tree'  (duration: 101.454946ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:10.841856Z","caller":"traceutil/trace.go:171","msg":"trace[2057589460] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1364; }","duration":"104.980731ms","start":"2026-03-20T10:16:10.736846Z","end":"2026-03-20T10:16:10.841826Z","steps":["trace[2057589460] 'range keys from in-memory index tree'  (duration: 104.639381ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:08.222922Z","caller":"traceutil/trace.go:171","msg":"trace[1260242429] linearizableReadLoop","detail":"{readStateIndex:1667; appliedIndex:1666; }","duration":"107.325352ms","start":"2026-03-20T10:17:08.11553Z","end":"2026-03-20T10:17:08.222856Z","steps":["trace[1260242429] 'read index received'  (duration: 107.191419ms)","trace[1260242429] 'applied index is now lower than readState.Index'  (duration: 132.573µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:17:08.2231Z","caller":"traceutil/trace.go:171","msg":"trace[1033856341] transaction","detail":"{read_only:false; response_revision:1598; number_of_response:1; }","duration":"147.395024ms","start":"2026-03-20T10:17:08.075674Z","end":"2026-03-20T10:17:08.223069Z","steps":["trace[1033856341] 'process raft request'  (duration: 147.007673ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:17:08.223141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.593009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:6624"}
{"level":"info","ts":"2026-03-20T10:17:08.223787Z","caller":"traceutil/trace.go:171","msg":"trace[1834858125] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1598; }","duration":"108.258286ms","start":"2026-03-20T10:17:08.115481Z","end":"2026-03-20T10:17:08.22374Z","steps":["trace[1834858125] 'agreement among raft nodes before linearized reading'  (duration: 107.518417ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:17:23.560049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.601531ms","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-20T10:17:23.560145Z","caller":"traceutil/trace.go:171","msg":"trace[1998541131] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1659; }","duration":"140.710285ms","start":"2026-03-20T10:17:23.419409Z","end":"2026-03-20T10:17:23.560119Z","steps":["trace[1998541131] 'range keys from in-memory index tree'  (duration: 140.408426ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:17:23.560524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.420993ms","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-20T10:17:23.560672Z","caller":"traceutil/trace.go:171","msg":"trace[1535101399] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1659; }","duration":"138.637378ms","start":"2026-03-20T10:17:23.422002Z","end":"2026-03-20T10:17:23.56064Z","steps":["trace[1535101399] 'range keys from in-memory index tree'  (duration: 137.973491ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:23.826262Z","caller":"traceutil/trace.go:171","msg":"trace[1665345533] transaction","detail":"{read_only:false; response_revision:1662; number_of_response:1; }","duration":"260.826925ms","start":"2026-03-20T10:17:23.565414Z","end":"2026-03-20T10:17:23.826241Z","steps":["trace[1665345533] 'process raft request'  (duration: 260.785895ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:23.826545Z","caller":"traceutil/trace.go:171","msg":"trace[756165287] transaction","detail":"{read_only:false; response_revision:1661; number_of_response:1; }","duration":"261.338939ms","start":"2026-03-20T10:17:23.565195Z","end":"2026-03-20T10:17:23.826534Z","steps":["trace[756165287] 'process raft request'  (duration: 260.874757ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:26.804485Z","caller":"traceutil/trace.go:171","msg":"trace[52063326] transaction","detail":"{read_only:false; response_revision:1673; number_of_response:1; }","duration":"205.329032ms","start":"2026-03-20T10:17:26.599137Z","end":"2026-03-20T10:17:26.804466Z","steps":["trace[52063326] 'process raft request'  (duration: 205.183558ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:29.276377Z","caller":"traceutil/trace.go:171","msg":"trace[1316705281] linearizableReadLoop","detail":"{readStateIndex:1755; appliedIndex:1754; }","duration":"179.022267ms","start":"2026-03-20T10:17:29.09733Z","end":"2026-03-20T10:17:29.276352Z","steps":["trace[1316705281] 'read index received'  (duration: 178.666928ms)","trace[1316705281] 'applied index is now lower than readState.Index'  (duration: 354.429µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:17:29.276497Z","caller":"traceutil/trace.go:171","msg":"trace[1454521153] transaction","detail":"{read_only:false; response_revision:1682; number_of_response:1; }","duration":"184.959838ms","start":"2026-03-20T10:17:29.091473Z","end":"2026-03-20T10:17:29.276433Z","steps":["trace[1454521153] 'process raft request'  (duration: 184.613039ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:17:29.276643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.296926ms","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:508"}
{"level":"info","ts":"2026-03-20T10:17:29.276702Z","caller":"traceutil/trace.go:171","msg":"trace[851980150] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1682; }","duration":"179.388637ms","start":"2026-03-20T10:17:29.097294Z","end":"2026-03-20T10:17:29.276682Z","steps":["trace[851980150] 'agreement among raft nodes before linearized reading'  (duration: 179.166921ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:17:29.484997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.027928ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740572047 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:1663 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:423 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:17:29.485238Z","caller":"traceutil/trace.go:171","msg":"trace[977678625] linearizableReadLoop","detail":"{readStateIndex:1757; appliedIndex:1755; }","duration":"158.974793ms","start":"2026-03-20T10:17:29.326239Z","end":"2026-03-20T10:17:29.485214Z","steps":["trace[977678625] 'read index received'  (duration: 31.74011ms)","trace[977678625] 'applied index is now lower than readState.Index'  (duration: 127.232893ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:17:29.485372Z","caller":"traceutil/trace.go:171","msg":"trace[1343546085] transaction","detail":"{read_only:false; response_revision:1683; number_of_response:1; }","duration":"203.520873ms","start":"2026-03-20T10:17:29.28182Z","end":"2026-03-20T10:17:29.485341Z","steps":["trace[1343546085] 'process raft request'  (duration: 75.986462ms)","trace[1343546085] 'compare'  (duration: 126.847272ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:17:29.485378Z","caller":"traceutil/trace.go:171","msg":"trace[286462000] transaction","detail":"{read_only:false; response_revision:1684; number_of_response:1; }","duration":"180.147528ms","start":"2026-03-20T10:17:29.305197Z","end":"2026-03-20T10:17:29.485345Z","steps":["trace[286462000] 'process raft request'  (duration: 179.944532ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:17:29.485765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.521946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-03-20T10:17:29.485813Z","caller":"traceutil/trace.go:171","msg":"trace[1674216035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1684; }","duration":"159.607158ms","start":"2026-03-20T10:17:29.326193Z","end":"2026-03-20T10:17:29.485801Z","steps":["trace[1674216035] 'agreement among raft nodes before linearized reading'  (duration: 159.149456ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:17:32.331341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.195108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:17:32.331425Z","caller":"traceutil/trace.go:171","msg":"trace[651487200] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1697; }","duration":"119.298931ms","start":"2026-03-20T10:17:32.212107Z","end":"2026-03-20T10:17:32.331406Z","steps":["trace[651487200] 'range keys from in-memory index tree'  (duration: 119.104906ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:52.519772Z","caller":"traceutil/trace.go:171","msg":"trace[1967907010] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"127.892531ms","start":"2026-03-20T10:17:52.391854Z","end":"2026-03-20T10:17:52.519746Z","steps":["trace[1967907010] 'process raft request'  (duration: 127.746757ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:17:53.039084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.188118ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740572359 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1796 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:17:53.039193Z","caller":"traceutil/trace.go:171","msg":"trace[1313050775] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"510.209436ms","start":"2026-03-20T10:17:52.528965Z","end":"2026-03-20T10:17:53.039175Z","steps":["trace[1313050775] 'process raft request'  (duration: 338.72542ms)","trace[1313050775] 'compare'  (duration: 171.084315ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:17:53.039255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:17:52.528944Z","time spent":"510.283587ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1796 > 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-20T10:18:01.262794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.524437ms","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-20T10:18:01.262881Z","caller":"traceutil/trace.go:171","msg":"trace[1649003913] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1842; }","duration":"119.774873ms","start":"2026-03-20T10:18:01.143086Z","end":"2026-03-20T10:18:01.262861Z","steps":["trace[1649003913] 'range keys from in-memory index tree'  (duration: 119.228289ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:01.263111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.981935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:18:01.263086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.463559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"}
{"level":"info","ts":"2026-03-20T10:18:01.26318Z","caller":"traceutil/trace.go:171","msg":"trace[1309604190] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1842; }","duration":"361.089438ms","start":"2026-03-20T10:18:00.902073Z","end":"2026-03-20T10:18:01.263162Z","steps":["trace[1309604190] 'range keys from in-memory index tree'  (duration: 360.876122ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:01.263218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:00.902051Z","time spent":"361.157009ms","remote":"127.0.0.1:34870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "}
{"level":"info","ts":"2026-03-20T10:18:01.263237Z","caller":"traceutil/trace.go:171","msg":"trace[2061996308] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1842; }","duration":"238.653112ms","start":"2026-03-20T10:18:01.024526Z","end":"2026-03-20T10:18:01.263179Z","steps":["trace[2061996308] 'range keys from in-memory index tree'  (duration: 238.110239ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:01.506045Z","caller":"traceutil/trace.go:171","msg":"trace[969999816] linearizableReadLoop","detail":"{readStateIndex:1924; appliedIndex:1923; }","duration":"237.384459ms","start":"2026-03-20T10:18:01.268638Z","end":"2026-03-20T10:18:01.506023Z","steps":["trace[969999816] 'read index received'  (duration: 237.229874ms)","trace[969999816] 'applied index is now lower than readState.Index'  (duration: 153.655µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:18:01.506283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.588516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:18:01.50637Z","caller":"traceutil/trace.go:171","msg":"trace[917665937] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1843; }","duration":"237.75374ms","start":"2026-03-20T10:18:01.268597Z","end":"2026-03-20T10:18:01.506351Z","steps":["trace[917665937] 'agreement among raft nodes before linearized reading'  (duration: 237.563034ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:01.506445Z","caller":"traceutil/trace.go:171","msg":"trace[2126961736] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"237.76348ms","start":"2026-03-20T10:18:01.26838Z","end":"2026-03-20T10:18:01.506144Z","steps":["trace[2126961736] 'process raft request'  (duration: 237.513764ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:01.866283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.190021ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740572464 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1819 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:18:01.866512Z","caller":"traceutil/trace.go:171","msg":"trace[1586707830] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1924; }","duration":"360.337997ms","start":"2026-03-20T10:18:01.506124Z","end":"2026-03-20T10:18:01.866462Z","steps":["trace[1586707830] 'read index received'  (duration: 124.923571ms)","trace[1586707830] 'applied index is now lower than readState.Index'  (duration: 235.412786ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:18:01.866549Z","caller":"traceutil/trace.go:171","msg":"trace[180252557] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"596.950486ms","start":"2026-03-20T10:18:01.269569Z","end":"2026-03-20T10:18:01.86652Z","steps":["trace[180252557] 'process raft request'  (duration: 361.426167ms)","trace[180252557] 'compare'  (duration: 235.064177ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:18:01.866676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:01.269552Z","time spent":"597.056518ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1819 > 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-20T10:18:01.86682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.301031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"}
{"level":"info","ts":"2026-03-20T10:18:01.866891Z","caller":"traceutil/trace.go:171","msg":"trace[1407429352] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1844; }","duration":"540.446985ms","start":"2026-03-20T10:18:01.326432Z","end":"2026-03-20T10:18:01.866879Z","steps":["trace[1407429352] 'agreement among raft nodes before linearized reading'  (duration: 540.226139ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:01.866962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:01.326413Z","time spent":"540.537226ms","remote":"127.0.0.1:35006","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-20T10:18:01.867009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.705208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-03-20T10:18:01.86704Z","caller":"traceutil/trace.go:171","msg":"trace[582856127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1844; }","duration":"120.77867ms","start":"2026-03-20T10:18:01.746254Z","end":"2026-03-20T10:18:01.867033Z","steps":["trace[582856127] 'agreement among raft nodes before linearized reading'  (duration: 120.673337ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:01.867384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.537729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-20T10:18:01.867456Z","caller":"traceutil/trace.go:171","msg":"trace[82001902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1844; }","duration":"404.663254ms","start":"2026-03-20T10:18:01.462777Z","end":"2026-03-20T10:18:01.86744Z","steps":["trace[82001902] 'agreement among raft nodes before linearized reading'  (duration: 403.810661ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:01.867493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:01.462757Z","time spent":"404.727785ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-20T10:18:02.286064Z","caller":"traceutil/trace.go:171","msg":"trace[107850778] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"414.371962ms","start":"2026-03-20T10:18:01.871666Z","end":"2026-03-20T10:18:02.286038Z","steps":["trace[107850778] 'process raft request'  (duration: 414.083194ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:02.286219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:01.871656Z","time spent":"414.481966ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1835 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:18:02.28629Z","caller":"traceutil/trace.go:171","msg":"trace[1148791605] linearizableReadLoop","detail":"{readStateIndex:1928; appliedIndex:1925; }","duration":"337.676992ms","start":"2026-03-20T10:18:01.948556Z","end":"2026-03-20T10:18:02.286233Z","steps":["trace[1148791605] 'read index received'  (duration: 8.416405ms)","trace[1148791605] 'applied index is now lower than readState.Index'  (duration: 329.257236ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:18:02.286431Z","caller":"traceutil/trace.go:171","msg":"trace[268955401] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"414.26382ms","start":"2026-03-20T10:18:01.871996Z","end":"2026-03-20T10:18:02.28626Z","steps":["trace[268955401] 'process raft request'  (duration: 413.982852ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:02.286698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.106682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-03-20T10:18:02.286702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.968414ms","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-20T10:18:02.28675Z","caller":"traceutil/trace.go:171","msg":"trace[424862044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1847; }","duration":"338.226056ms","start":"2026-03-20T10:18:01.948511Z","end":"2026-03-20T10:18:02.286737Z","steps":["trace[424862044] 'agreement among raft nodes before linearized reading'  (duration: 337.939149ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:02.286759Z","caller":"traceutil/trace.go:171","msg":"trace[533030233] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1847; }","duration":"140.079886ms","start":"2026-03-20T10:18:02.146665Z","end":"2026-03-20T10:18:02.286745Z","steps":["trace[533030233] 'agreement among raft nodes before linearized reading'  (duration: 139.87704ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:02.286798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:01.948497Z","time spent":"338.291319ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-20T10:18:02.286759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:01.871976Z","time spent":"414.591549ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1833 > 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-20T10:18:02.626253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.317659ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740572473 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1842 > 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-20T10:18:02.626643Z","caller":"traceutil/trace.go:171","msg":"trace[881874295] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"336.023688ms","start":"2026-03-20T10:18:02.290566Z","end":"2026-03-20T10:18:02.626589Z","steps":["trace[881874295] 'process raft request'  (duration: 71.281047ms)","trace[881874295] 'compare'  (duration: 264.201966ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:18:02.626867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:02.290537Z","time spent":"336.175192ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1842 > 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-20T10:18:02.626958Z","caller":"traceutil/trace.go:171","msg":"trace[1993036207] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"335.632087ms","start":"2026-03-20T10:18:02.291292Z","end":"2026-03-20T10:18:02.626924Z","steps":["trace[1993036207] 'process raft request'  (duration: 335.132314ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:02.627038Z","caller":"traceutil/trace.go:171","msg":"trace[1129314096] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"335.696819ms","start":"2026-03-20T10:18:02.29132Z","end":"2026-03-20T10:18:02.627017Z","steps":["trace[1129314096] 'process raft request'  (duration: 335.296488ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:02.627143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:02.291268Z","time spent":"335.813601ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1838 > 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-20T10:18:02.627383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:02.2913Z","time spent":"335.7822ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1837 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-20T10:18:03.866143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.838212ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740572477 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" mod_revision:1827 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:18:03.866233Z","caller":"traceutil/trace.go:171","msg":"trace[1591247464] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1931; }","duration":"861.666465ms","start":"2026-03-20T10:18:03.004551Z","end":"2026-03-20T10:18:03.866218Z","steps":["trace[1591247464] 'read index received'  (duration: 55.012µs)","trace[1591247464] 'applied index is now lower than readState.Index'  (duration: 861.610273ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:18:03.866784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.235971ms","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-20T10:18:03.866793Z","caller":"traceutil/trace.go:171","msg":"trace[639207490] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"1.23497499s","start":"2026-03-20T10:18:02.631803Z","end":"2026-03-20T10:18:03.866778Z","steps":["trace[639207490] 'process raft request'  (duration: 351.403308ms)","trace[639207490] 'compare'  (duration: 882.75272ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:18:03.866833Z","caller":"traceutil/trace.go:171","msg":"trace[1497540794] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1851; }","duration":"862.325983ms","start":"2026-03-20T10:18:03.004498Z","end":"2026-03-20T10:18:03.866824Z","steps":["trace[1497540794] 'agreement among raft nodes before linearized reading'  (duration: 862.25552ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:03.86683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.644058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:18:03.866858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:03.004476Z","time spent":"862.374903ms","remote":"127.0.0.1:34974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:18:03.866871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:02.631782Z","time spent":"1.235051251s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" mod_revision:1827 > 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-20T10:18:03.866889Z","caller":"traceutil/trace.go:171","msg":"trace[810163432] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1851; }","duration":"654.730691ms","start":"2026-03-20T10:18:03.212139Z","end":"2026-03-20T10:18:03.86687Z","steps":["trace[810163432] 'agreement among raft nodes before linearized reading'  (duration: 654.283619ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:03.866933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:03.212119Z","time spent":"654.803632ms","remote":"127.0.0.1:34720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:18:03.866993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.923599ms","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-20T10:18:03.867045Z","caller":"traceutil/trace.go:171","msg":"trace[843763393] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1851; }","duration":"355.97719ms","start":"2026-03-20T10:18:03.511053Z","end":"2026-03-20T10:18:03.86703Z","steps":["trace[843763393] 'agreement among raft nodes before linearized reading'  (duration: 355.811555ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:03.867116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:03.510995Z","time spent":"356.107865ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"warn","ts":"2026-03-20T10:18:04.790208Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512260740572480,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:18:05.144406Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.273955312s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T10:18:05.144689Z","caller":"traceutil/trace.go:171","msg":"trace[1017450408] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1932; }","duration":"854.73469ms","start":"2026-03-20T10:18:04.289935Z","end":"2026-03-20T10:18:05.14467Z","steps":["trace[1017450408] 'read index received'  (duration: 854.587455ms)","trace[1017450408] 'applied index is now lower than readState.Index'  (duration: 146.555µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:18:05.144911Z","caller":"traceutil/trace.go:171","msg":"trace[1271751056] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"1.274505906s","start":"2026-03-20T10:18:03.87036Z","end":"2026-03-20T10:18:05.144866Z","steps":["trace[1271751056] 'process raft request'  (duration: 1.274209899s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:05.145112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.696165ms","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-20T10:18:05.144961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.995328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-03-20T10:18:05.145248Z","caller":"traceutil/trace.go:171","msg":"trace[1741424731] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1852; }","duration":"511.883251ms","start":"2026-03-20T10:18:04.633341Z","end":"2026-03-20T10:18:05.145224Z","steps":["trace[1741424731] 'agreement among raft nodes before linearized reading'  (duration: 511.572132ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:05.145324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:04.633319Z","time spent":"511.995724ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-20T10:18:05.145254Z","caller":"traceutil/trace.go:171","msg":"trace[1344569460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1852; }","duration":"855.332776ms","start":"2026-03-20T10:18:04.289907Z","end":"2026-03-20T10:18:05.145239Z","steps":["trace[1344569460] 'agreement among raft nodes before linearized reading'  (duration: 854.871964ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:05.145691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:03.870335Z","time spent":"1.274792965s","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1843 > 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-20T10:18:05.144992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.153014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-20T10:18:05.146723Z","caller":"traceutil/trace.go:171","msg":"trace[1743083291] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1852; }","duration":"855.89876ms","start":"2026-03-20T10:18:04.290806Z","end":"2026-03-20T10:18:05.146704Z","steps":["trace[1743083291] 'agreement among raft nodes before linearized reading'  (duration: 854.072782ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:05.145044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.828619ms","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-20T10:18:05.145076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.585542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-03-20T10:18:05.144987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.553731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-20T10:18:05.145425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:04.289893Z","time spent":"855.51818ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-20T10:18:05.147021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:04.2908Z","time spent":"856.202499ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-20T10:18:05.147089Z","caller":"traceutil/trace.go:171","msg":"trace[393136467] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1852; }","duration":"596.898765ms","start":"2026-03-20T10:18:04.550172Z","end":"2026-03-20T10:18:05.147071Z","steps":["trace[393136467] 'agreement among raft nodes before linearized reading'  (duration: 594.83703ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:05.147659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:04.550152Z","time spent":"597.49378ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-03-20T10:18:05.147238Z","caller":"traceutil/trace.go:171","msg":"trace[496448851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1852; }","duration":"513.7516ms","start":"2026-03-20T10:18:04.633473Z","end":"2026-03-20T10:18:05.147224Z","steps":["trace[496448851] 'agreement among raft nodes before linearized reading'  (duration: 511.535221ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:05.147726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:04.633469Z","time spent":"514.239343ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-20T10:18:05.14736Z","caller":"traceutil/trace.go:171","msg":"trace[1446392188] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1852; }","duration":"513.971896ms","start":"2026-03-20T10:18:04.633378Z","end":"2026-03-20T10:18:05.14735Z","steps":["trace[1446392188] 'agreement among raft nodes before linearized reading'  (duration: 511.527771ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:05.148014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:04.633359Z","time spent":"514.642703ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-20T10:18:25.652176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.799006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"warn","ts":"2026-03-20T10:18:25.652187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.376589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-03-20T10:18:25.652275Z","caller":"traceutil/trace.go:171","msg":"trace[1843888936] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1941; }","duration":"346.920809ms","start":"2026-03-20T10:18:25.305332Z","end":"2026-03-20T10:18:25.652253Z","steps":["trace[1843888936] 'range keys from in-memory index tree'  (duration: 346.629661ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:25.652291Z","caller":"traceutil/trace.go:171","msg":"trace[503815324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1941; }","duration":"320.533682ms","start":"2026-03-20T10:18:25.331737Z","end":"2026-03-20T10:18:25.65227Z","steps":["trace[503815324] 'range keys from in-memory index tree'  (duration: 320.202433ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:25.652329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:25.305299Z","time spent":"347.020191ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"warn","ts":"2026-03-20T10:18:25.65234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:25.331719Z","time spent":"320.610334ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-20T10:18:25.652386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.984189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-20T10:18:25.652464Z","caller":"traceutil/trace.go:171","msg":"trace[1787125361] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1941; }","duration":"326.086791ms","start":"2026-03-20T10:18:25.326355Z","end":"2026-03-20T10:18:25.652442Z","steps":["trace[1787125361] 'range keys from in-memory index tree'  (duration: 325.846586ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:25.652429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.383124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-03-20T10:18:25.652505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.730524ms","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-20T10:18:25.652537Z","caller":"traceutil/trace.go:171","msg":"trace[676115211] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1941; }","duration":"334.521427ms","start":"2026-03-20T10:18:25.317992Z","end":"2026-03-20T10:18:25.652513Z","steps":["trace[676115211] 'range keys from in-memory index tree'  (duration: 334.199959ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:25.652581Z","caller":"traceutil/trace.go:171","msg":"trace[5703582] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1941; }","duration":"346.832256ms","start":"2026-03-20T10:18:25.305724Z","end":"2026-03-20T10:18:25.652556Z","steps":["trace[5703582] 'range keys from in-memory index tree'  (duration: 346.626822ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:25.652593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:25.317984Z","time spent":"334.596899ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-20T10:18:25.652578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.350529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-03-20T10:18:25.652643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:25.305706Z","time spent":"346.925629ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-20T10:18:25.652508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.206397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/cilium-config-agent\" ","response":"range_response_count:1 size:790"}
{"level":"info","ts":"2026-03-20T10:18:25.652747Z","caller":"traceutil/trace.go:171","msg":"trace[1393797032] range","detail":"{range_begin:/registry/rolebindings/kube-system/cilium-config-agent; range_end:; response_count:1; response_revision:1941; }","duration":"285.466565ms","start":"2026-03-20T10:18:25.367267Z","end":"2026-03-20T10:18:25.652734Z","steps":["trace[1393797032] 'range keys from in-memory index tree'  (duration: 285.104365ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:25.652647Z","caller":"traceutil/trace.go:171","msg":"trace[1399315215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1941; }","duration":"320.461801ms","start":"2026-03-20T10:18:25.332168Z","end":"2026-03-20T10:18:25.65263Z","steps":["trace[1399315215] 'range keys from in-memory index tree'  (duration: 320.183633ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:25.652926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:25.332147Z","time spent":"320.736869ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-20T10:18:25.652354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.186168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:951"}
{"level":"info","ts":"2026-03-20T10:18:25.65304Z","caller":"traceutil/trace.go:171","msg":"trace[27615712] range","detail":"{range_begin:/registry/rolebindings/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:1941; }","duration":"343.9234ms","start":"2026-03-20T10:18:25.3091Z","end":"2026-03-20T10:18:25.653023Z","steps":["trace[27615712] 'range keys from in-memory index tree'  (duration: 343.009904ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:25.653099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:25.309093Z","time spent":"343.990111ms","remote":"127.0.0.1:35076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":974,"request content":"key:\"/registry/rolebindings/kube-system/ceph-csi-rbd-provisioner\" "}
{"level":"warn","ts":"2026-03-20T10:18:25.652509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:25.326343Z","time spent":"326.157003ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-20T10:18:25.791746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.479495ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512260740573375 > lease_revoke:<id:0e099d0abb64e5d9>","response":"size:28"}
{"level":"info","ts":"2026-03-20T10:18:25.792107Z","caller":"traceutil/trace.go:171","msg":"trace[1425758563] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"133.650645ms","start":"2026-03-20T10:18:25.658436Z","end":"2026-03-20T10:18:25.792087Z","steps":["trace[1425758563] 'process raft request'  (duration: 133.464919ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:25.825095Z","caller":"traceutil/trace.go:171","msg":"trace[533740010] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"166.40805ms","start":"2026-03-20T10:18:25.658648Z","end":"2026-03-20T10:18:25.825056Z","steps":["trace[533740010] 'process raft request'  (duration: 166.175844ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:25.825418Z","caller":"traceutil/trace.go:171","msg":"trace[145180563] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"166.655037ms","start":"2026-03-20T10:18:25.658732Z","end":"2026-03-20T10:18:25.825387Z","steps":["trace[145180563] 'process raft request'  (duration: 166.273507ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:25.825515Z","caller":"traceutil/trace.go:171","msg":"trace[1341472778] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"166.701389ms","start":"2026-03-20T10:18:25.658786Z","end":"2026-03-20T10:18:25.825487Z","steps":["trace[1341472778] 'process raft request'  (duration: 166.498513ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:25.825672Z","caller":"traceutil/trace.go:171","msg":"trace[108088139] linearizableReadLoop","detail":"{readStateIndex:2033; appliedIndex:2027; }","duration":"166.593126ms","start":"2026-03-20T10:18:25.659064Z","end":"2026-03-20T10:18:25.825657Z","steps":["trace[108088139] 'read index received'  (duration: 67.376462ms)","trace[108088139] 'applied index is now lower than readState.Index'  (duration: 99.215344ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:18:25.82569Z","caller":"traceutil/trace.go:171","msg":"trace[645932915] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"166.807391ms","start":"2026-03-20T10:18:25.658871Z","end":"2026-03-20T10:18:25.825678Z","steps":["trace[645932915] 'process raft request'  (duration: 166.511523ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:25.825724Z","caller":"traceutil/trace.go:171","msg":"trace[1356153164] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"166.435661ms","start":"2026-03-20T10:18:25.659261Z","end":"2026-03-20T10:18:25.825697Z","steps":["trace[1356153164] 'process raft request'  (duration: 166.331719ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:25.826129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.887045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/cilium-config-agent\" ","response":"range_response_count:1 size:790"}
{"level":"warn","ts":"2026-03-20T10:18:25.826143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.052328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:951"}
{"level":"info","ts":"2026-03-20T10:18:25.826177Z","caller":"traceutil/trace.go:171","msg":"trace[147056539] range","detail":"{range_begin:/registry/rolebindings/kube-system/cilium-config-agent; range_end:; response_count:1; response_revision:1947; }","duration":"104.999209ms","start":"2026-03-20T10:18:25.721165Z","end":"2026-03-20T10:18:25.826164Z","steps":["trace[147056539] 'agreement among raft nodes before linearized reading'  (duration: 104.884396ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:25.82619Z","caller":"traceutil/trace.go:171","msg":"trace[1236081551] range","detail":"{range_begin:/registry/rolebindings/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:1947; }","duration":"167.13578ms","start":"2026-03-20T10:18:25.659037Z","end":"2026-03-20T10:18:25.826172Z","steps":["trace[1236081551] 'agreement among raft nodes before linearized reading'  (duration: 166.916104ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:38.165067Z","caller":"traceutil/trace.go:171","msg":"trace[897806158] transaction","detail":"{read_only:false; response_revision:1995; number_of_response:1; }","duration":"282.362645ms","start":"2026-03-20T10:18:37.882668Z","end":"2026-03-20T10:18:38.16503Z","steps":["trace[897806158] 'process raft request'  (duration: 282.250632ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:38.165095Z","caller":"traceutil/trace.go:171","msg":"trace[114194133] linearizableReadLoop","detail":"{readStateIndex:2084; appliedIndex:2081; }","duration":"240.856201ms","start":"2026-03-20T10:18:37.924205Z","end":"2026-03-20T10:18:38.165061Z","steps":["trace[114194133] 'read index received'  (duration: 229.302572ms)","trace[114194133] 'applied index is now lower than readState.Index'  (duration: 11.551739ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:18:38.16509Z","caller":"traceutil/trace.go:171","msg":"trace[1535619722] transaction","detail":"{read_only:false; response_revision:1994; number_of_response:1; }","duration":"282.765935ms","start":"2026-03-20T10:18:37.882263Z","end":"2026-03-20T10:18:38.165028Z","steps":["trace[1535619722] 'process raft request'  (duration: 282.59372ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:38.165171Z","caller":"traceutil/trace.go:171","msg":"trace[1461126769] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"282.96417ms","start":"2026-03-20T10:18:37.882194Z","end":"2026-03-20T10:18:38.165158Z","steps":["trace[1461126769] 'process raft request'  (duration: 271.224385ms)","trace[1461126769] 'compare'  (duration: 11.20783ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:18:38.165079Z","caller":"traceutil/trace.go:171","msg":"trace[1912827177] transaction","detail":"{read_only:false; response_revision:1996; number_of_response:1; }","duration":"236.332339ms","start":"2026-03-20T10:18:37.928721Z","end":"2026-03-20T10:18:38.165053Z","steps":["trace[1912827177] 'process raft request'  (duration: 236.259768ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:38.165372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.954386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4zbjm\" ","response":"range_response_count:1 size:18521"}
{"level":"info","ts":"2026-03-20T10:18:38.165436Z","caller":"traceutil/trace.go:171","msg":"trace[711971297] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4zbjm; range_end:; response_count:1; response_revision:1996; }","duration":"256.034419ms","start":"2026-03-20T10:18:37.909369Z","end":"2026-03-20T10:18:38.165404Z","steps":["trace[711971297] 'agreement among raft nodes before linearized reading'  (duration: 255.806413ms)"],"step_count":1}