{"level":"warn","ts":"2026-03-20T10:14:04.18018Z","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:14:04.180273Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.133:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.133:2380","--initial-cluster=instance=https://199.19.213.133:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.133:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.133: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:14:04.180349Z","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:14:04.18036Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.133:2380"]}
{"level":"info","ts":"2026-03-20T10:14:04.180379Z","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:14:04.181034Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.133:2379"]}
{"level":"info","ts":"2026-03-20T10:14:04.181108Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.133:2380"],"listen-peer-urls":["https://199.19.213.133:2380"],"advertise-client-urls":["https://199.19.213.133:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.133:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.133: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:14:04.186841Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.031138ms"}
{"level":"info","ts":"2026-03-20T10:14:04.200459Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"21b354698260dd82","cluster-id":"b778216e1db811d5"}
{"level":"info","ts":"2026-03-20T10:14:04.200582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-20T10:14:04.200618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became follower at term 0"}
{"level":"info","ts":"2026-03-20T10:14:04.200642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 21b354698260dd82 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-20T10:14:04.200661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became follower at term 1"}
{"level":"info","ts":"2026-03-20T10:14:04.200721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 switched to configuration voters=(2428377436218514818)"}
{"level":"warn","ts":"2026-03-20T10:14:04.216731Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-20T10:14:04.220908Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-20T10:14:04.22188Z","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:14:04.223828Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"21b354698260dd82","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-20T10:14:04.232542Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"21b354698260dd82","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-20T10:14:04.232368Z","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:14:04.232679Z","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:14:04.232731Z","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:14:04.23359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 switched to configuration voters=(2428377436218514818)"}
{"level":"info","ts":"2026-03-20T10:14:04.233703Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b778216e1db811d5","local-member-id":"21b354698260dd82","added-peer-id":"21b354698260dd82","added-peer-peer-urls":["https://199.19.213.133:2380"]}
{"level":"info","ts":"2026-03-20T10:14:04.233836Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.133:2380"}
{"level":"info","ts":"2026-03-20T10:14:04.23387Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.133:2380"}
{"level":"info","ts":"2026-03-20T10:14:04.233689Z","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:14:04.234453Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"21b354698260dd82","initial-advertise-peer-urls":["https://199.19.213.133:2380"],"listen-peer-urls":["https://199.19.213.133:2380"],"advertise-client-urls":["https://199.19.213.133:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.133:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-20T10:14:04.234492Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-20T10:14:05.203475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-20T10:14:05.203518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-20T10:14:05.203532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 received MsgPreVoteResp from 21b354698260dd82 at term 1"}
{"level":"info","ts":"2026-03-20T10:14:05.203543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became candidate at term 2"}
{"level":"info","ts":"2026-03-20T10:14:05.203548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 received MsgVoteResp from 21b354698260dd82 at term 2"}
{"level":"info","ts":"2026-03-20T10:14:05.203556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became leader at term 2"}
{"level":"info","ts":"2026-03-20T10:14:05.2036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 21b354698260dd82 elected leader 21b354698260dd82 at term 2"}
{"level":"info","ts":"2026-03-20T10:14:05.20679Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"21b354698260dd82","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.133:2379]}","request-path":"/0/members/21b354698260dd82/attributes","cluster-id":"b778216e1db811d5","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-20T10:14:05.206805Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T10:14:05.206897Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T10:14:05.207707Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-20T10:14:05.207767Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-20T10:14:05.209191Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:14:05.210001Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.133:2379"}
{"level":"info","ts":"2026-03-20T10:14:05.210227Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b778216e1db811d5","local-member-id":"21b354698260dd82","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:14:05.210366Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:14:05.210396Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:14:05.212002Z","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:14:07.62811Z","caller":"traceutil/trace.go:171","msg":"trace[696850867] linearizableReadLoop","detail":"{readStateIndex:117; appliedIndex:116; }","duration":"164.56689ms","start":"2026-03-20T10:14:07.463523Z","end":"2026-03-20T10:14:07.62809Z","steps":["trace[696850867] 'read index received'  (duration: 164.373345ms)","trace[696850867] 'applied index is now lower than readState.Index'  (duration: 192.655µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:07.628176Z","caller":"traceutil/trace.go:171","msg":"trace[1443680131] transaction","detail":"{read_only:false; response_revision:112; number_of_response:1; }","duration":"166.166027ms","start":"2026-03-20T10:14:07.461987Z","end":"2026-03-20T10:14:07.628153Z","steps":["trace[1443680131] 'process raft request'  (duration: 165.983693ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:07.628299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.762074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-20T10:14:07.628363Z","caller":"traceutil/trace.go:171","msg":"trace[468910615] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:112; }","duration":"164.875917ms","start":"2026-03-20T10:14:07.463476Z","end":"2026-03-20T10:14:07.628352Z","steps":["trace[468910615] 'agreement among raft nodes before linearized reading'  (duration: 164.726913ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:15.582576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.93066ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15961492698798664810 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-proxy-j2tzp.189e851b308aabb9\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-proxy-j2tzp.189e851b308aabb9\" value_size:697 lease:6738120661943888332 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:14:15.582679Z","caller":"traceutil/trace.go:171","msg":"trace[531009218] linearizableReadLoop","detail":"{readStateIndex:401; appliedIndex:400; }","duration":"444.077401ms","start":"2026-03-20T10:14:15.138573Z","end":"2026-03-20T10:14:15.582651Z","steps":["trace[531009218] 'read index received'  (duration: 149.521216ms)","trace[531009218] 'applied index is now lower than readState.Index'  (duration: 294.555335ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:15.582715Z","caller":"traceutil/trace.go:171","msg":"trace[1407279885] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"524.282263ms","start":"2026-03-20T10:14:15.058395Z","end":"2026-03-20T10:14:15.582677Z","steps":["trace[1407279885] 'process raft request'  (duration: 229.713707ms)","trace[1407279885] 'compare'  (duration: 293.807908ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:15.582813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.233955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-03-20T10:14:15.582845Z","caller":"traceutil/trace.go:171","msg":"trace[2016748450] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:391; }","duration":"444.299556ms","start":"2026-03-20T10:14:15.138534Z","end":"2026-03-20T10:14:15.582834Z","steps":["trace[2016748450] 'agreement among raft nodes before linearized reading'  (duration: 444.205774ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:15.582877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:15.138514Z","time spent":"444.350287ms","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-20T10:14:15.582848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:15.058372Z","time spent":"524.412405ms","remote":"127.0.0.1:37582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":777,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-proxy-j2tzp.189e851b308aabb9\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-proxy-j2tzp.189e851b308aabb9\" value_size:697 lease:6738120661943888332 >> failure:<>"}
{"level":"warn","ts":"2026-03-20T10:14:15.583097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.562267ms","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:15.583126Z","caller":"traceutil/trace.go:171","msg":"trace[809491304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:391; }","duration":"191.632189ms","start":"2026-03-20T10:14:15.391488Z","end":"2026-03-20T10:14:15.58312Z","steps":["trace[809491304] 'agreement among raft nodes before linearized reading'  (duration: 191.581868ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:15.58319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.279371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"}
{"level":"info","ts":"2026-03-20T10:14:15.583205Z","caller":"traceutil/trace.go:171","msg":"trace[763732591] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:391; }","duration":"152.332362ms","start":"2026-03-20T10:14:15.430868Z","end":"2026-03-20T10:14:15.583201Z","steps":["trace[763732591] 'agreement among raft nodes before linearized reading'  (duration: 152.301181ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:17.535532Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492698798664812,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:14:17.988858Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.400956732s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T10:14:17.990794Z","caller":"traceutil/trace.go:171","msg":"trace[1682068825] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"2.402950049s","start":"2026-03-20T10:14:15.587802Z","end":"2026-03-20T10:14:17.990752Z","steps":["trace[1682068825] 'process raft request'  (duration: 2.401457163s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:17.991135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:15.587754Z","time spent":"2.403122873s","remote":"127.0.0.1:37746","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:339 > 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:14:18.732712Z","caller":"traceutil/trace.go:171","msg":"trace[1850549329] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"3.144798271s","start":"2026-03-20T10:14:15.587868Z","end":"2026-03-20T10:14:18.732666Z","steps":["trace[1850549329] 'process raft request'  (duration: 3.144588626s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:18.7328Z","caller":"traceutil/trace.go:171","msg":"trace[1791442916] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"3.144827361s","start":"2026-03-20T10:14:15.587854Z","end":"2026-03-20T10:14:18.732682Z","steps":["trace[1791442916] 'process raft request'  (duration: 3.144463132s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:18.732902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:15.587838Z","time spent":"3.144963765s","remote":"127.0.0.1:37746","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:341 > 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:18.733126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:15.58783Z","time spent":"3.145117078s","remote":"127.0.0.1:37746","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:343 > 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:18.733186Z","caller":"traceutil/trace.go:171","msg":"trace[1760451581] linearizableReadLoop","detail":"{readStateIndex:406; appliedIndex:401; }","duration":"1.697679289s","start":"2026-03-20T10:14:17.035467Z","end":"2026-03-20T10:14:18.733146Z","steps":["trace[1760451581] 'read index received'  (duration: 953.628776ms)","trace[1760451581] 'applied index is now lower than readState.Index'  (duration: 744.049353ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:18.733235Z","caller":"traceutil/trace.go:171","msg":"trace[328784482] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"3.140844877s","start":"2026-03-20T10:14:15.592359Z","end":"2026-03-20T10:14:18.733204Z","steps":["trace[328784482] 'process raft request'  (duration: 3.140167861s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:18.733369Z","caller":"traceutil/trace.go:171","msg":"trace[852861195] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"1.915364093s","start":"2026-03-20T10:14:16.817991Z","end":"2026-03-20T10:14:18.733355Z","steps":["trace[852861195] 'process raft request'  (duration: 1.915018905s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:18.733401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:15.592345Z","time spent":"3.14097283s","remote":"127.0.0.1:37688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6740,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:389 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:6673 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:18.73348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.970539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.133\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-03-20T10:14:18.733505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.698043488s","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:14:18.73351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:16.817953Z","time spent":"1.915451985s","remote":"127.0.0.1:37746","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:70 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-03-20T10:14:18.733567Z","caller":"traceutil/trace.go:171","msg":"trace[2045303857] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:396; }","duration":"1.69816278s","start":"2026-03-20T10:14:17.035388Z","end":"2026-03-20T10:14:18.733551Z","steps":["trace[2045303857] 'agreement among raft nodes before linearized reading'  (duration: 1.698011677s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:18.733574Z","caller":"traceutil/trace.go:171","msg":"trace[595146998] range","detail":"{range_begin:/registry/masterleases/199.19.213.133; range_end:; response_count:1; response_revision:396; }","duration":"369.108522ms","start":"2026-03-20T10:14:18.364435Z","end":"2026-03-20T10:14:18.733543Z","steps":["trace[595146998] 'agreement among raft nodes before linearized reading'  (duration: 368.942428ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:18.733614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:17.035355Z","time spent":"1.698248143s","remote":"127.0.0.1:37746","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:18.733621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:18.364415Z","time spent":"369.195675ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.133\" "}
{"level":"info","ts":"2026-03-20T10:14:23.061378Z","caller":"traceutil/trace.go:171","msg":"trace[909119762] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:424; }","duration":"258.429904ms","start":"2026-03-20T10:14:22.802926Z","end":"2026-03-20T10:14:23.061356Z","steps":["trace[909119762] 'read index received'  (duration: 28.702487ms)","trace[909119762] 'applied index is now lower than readState.Index'  (duration: 229.726007ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:23.061558Z","caller":"traceutil/trace.go:171","msg":"trace[1631934409] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"258.986376ms","start":"2026-03-20T10:14:22.802522Z","end":"2026-03-20T10:14:23.061509Z","steps":["trace[1631934409] 'process raft request'  (duration: 258.776721ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:23.061722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.757931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"}
{"level":"info","ts":"2026-03-20T10:14:23.06184Z","caller":"traceutil/trace.go:171","msg":"trace[891236782] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:415; }","duration":"258.942986ms","start":"2026-03-20T10:14:22.802874Z","end":"2026-03-20T10:14:23.061817Z","steps":["trace[891236782] 'agreement among raft nodes before linearized reading'  (duration: 258.639488ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:23.062079Z","caller":"traceutil/trace.go:171","msg":"trace[1962214713] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"259.13933ms","start":"2026-03-20T10:14:22.80232Z","end":"2026-03-20T10:14:23.061459Z","steps":["trace[1962214713] 'process raft request'  (duration: 219.28851ms)","trace[1962214713] 'compare'  (duration: 39.500622ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:23.699597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.508ms","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:23.699675Z","caller":"traceutil/trace.go:171","msg":"trace[719375650] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:416; }","duration":"318.656834ms","start":"2026-03-20T10:14:23.380999Z","end":"2026-03-20T10:14:23.699656Z","steps":["trace[719375650] 'range keys from in-memory index tree'  (duration: 318.359747ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:23.699718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:23.380969Z","time spent":"318.740266ms","remote":"127.0.0.1:37496","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:24.125067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.654914ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15961492698798664863 > lease_revoke:<id:5d829d0abce2ab1d>","response":"size:28"}
{"level":"info","ts":"2026-03-20T10:14:24.125186Z","caller":"traceutil/trace.go:171","msg":"trace[467278726] linearizableReadLoop","detail":"{readStateIndex:429; appliedIndex:428; }","duration":"111.595632ms","start":"2026-03-20T10:14:24.013568Z","end":"2026-03-20T10:14:24.125164Z","steps":["trace[467278726] 'read index received'  (duration: 49.442µs)","trace[467278726] 'applied index is now lower than readState.Index'  (duration: 111.54431ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:24.125308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.723165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-03-20T10:14:24.125349Z","caller":"traceutil/trace.go:171","msg":"trace[1151686790] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:416; }","duration":"111.807977ms","start":"2026-03-20T10:14:24.013528Z","end":"2026-03-20T10:14:24.125336Z","steps":["trace[1151686790] 'agreement among raft nodes before linearized reading'  (duration: 111.695984ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:24.376607Z","caller":"traceutil/trace.go:171","msg":"trace[230817432] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"247.339472ms","start":"2026-03-20T10:14:24.129245Z","end":"2026-03-20T10:14:24.376584Z","steps":["trace[230817432] 'process raft request'  (duration: 247.181469ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:24.802163Z","caller":"traceutil/trace.go:171","msg":"trace[747356005] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"113.816394ms","start":"2026-03-20T10:14:24.688323Z","end":"2026-03-20T10:14:24.802139Z","steps":["trace[747356005] 'process raft request'  (duration: 113.593789ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:39.200289Z","caller":"traceutil/trace.go:171","msg":"trace[223102912] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"178.641752ms","start":"2026-03-20T10:14:39.021624Z","end":"2026-03-20T10:14:39.200265Z","steps":["trace[223102912] 'process raft request'  (duration: 178.431647ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:39.548109Z","caller":"traceutil/trace.go:171","msg":"trace[1026430742] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"104.415722ms","start":"2026-03-20T10:14:39.443666Z","end":"2026-03-20T10:14:39.548082Z","steps":["trace[1026430742] 'process raft request'  (duration: 104.244728ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:42.186324Z","caller":"traceutil/trace.go:171","msg":"trace[1232962873] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"737.821757ms","start":"2026-03-20T10:14:41.448478Z","end":"2026-03-20T10:14:42.1863Z","steps":["trace[1232962873] 'process raft request'  (duration: 737.658513ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:42.186485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:41.448462Z","time spent":"737.94394ms","remote":"127.0.0.1:37746","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:463 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-03-20T10:14:42.193266Z","caller":"traceutil/trace.go:171","msg":"trace[564790583] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"493.811763ms","start":"2026-03-20T10:14:41.699435Z","end":"2026-03-20T10:14:42.193247Z","steps":["trace[564790583] 'process raft request'  (duration: 493.570887ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:42.193348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:41.699415Z","time spent":"493.897205ms","remote":"127.0.0.1:37572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" value_size:4142 >> failure:<>"}
{"level":"info","ts":"2026-03-20T10:14:42.193471Z","caller":"traceutil/trace.go:171","msg":"trace[564388860] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"293.208484ms","start":"2026-03-20T10:14:41.900253Z","end":"2026-03-20T10:14:42.193462Z","steps":["trace[564388860] 'process raft request'  (duration: 292.786794ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:42.193844Z","caller":"traceutil/trace.go:171","msg":"trace[374747446] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"689.248512ms","start":"2026-03-20T10:14:41.50454Z","end":"2026-03-20T10:14:42.193789Z","steps":["trace[374747446] 'process raft request'  (duration: 688.390271ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:42.194074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:41.504519Z","time spent":"689.458946ms","remote":"127.0.0.1:37572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" value_size:23189 >> failure:<>"}
{"level":"warn","ts":"2026-03-20T10:14:44.467097Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492698798665167,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:14:44.503609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.149065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.503658Z","caller":"traceutil/trace.go:171","msg":"trace[1845916006] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:569; }","duration":"567.217958ms","start":"2026-03-20T10:14:43.936428Z","end":"2026-03-20T10:14:44.503646Z","steps":["trace[1845916006] 'range keys from in-memory index tree'  (duration: 567.121685ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.50368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.936425Z","time spent":"567.249768ms","remote":"127.0.0.1:59392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "}
{"level":"warn","ts":"2026-03-20T10:14:44.503782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.938279Z","time spent":"565.50085ms","remote":"127.0.0.1:59404","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-20T10:14:44.503859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.509864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.503886Z","caller":"traceutil/trace.go:171","msg":"trace[1613126322] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:569; }","duration":"567.562085ms","start":"2026-03-20T10:14:43.936316Z","end":"2026-03-20T10:14:44.503878Z","steps":["trace[1613126322] 'range keys from in-memory index tree'  (duration: 567.391361ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.503842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.405871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:14:44.503902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.936302Z","time spent":"567.594945ms","remote":"127.0.0.1:59392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "}
{"level":"warn","ts":"2026-03-20T10:14:44.503855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.401456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:14:44.503888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.569703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.503932Z","caller":"traceutil/trace.go:171","msg":"trace[1071554518] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:569; }","duration":"567.528984ms","start":"2026-03-20T10:14:43.936383Z","end":"2026-03-20T10:14:44.503912Z","steps":["trace[1071554518] 'count revisions from in-memory index tree'  (duration: 567.364161ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:44.503968Z","caller":"traceutil/trace.go:171","msg":"trace[595169344] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:569; }","duration":"549.680496ms","start":"2026-03-20T10:14:43.95427Z","end":"2026-03-20T10:14:44.50395Z","steps":["trace[595169344] 'range keys from in-memory index tree'  (duration: 549.522013ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.504008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.954263Z","time spent":"549.735897ms","remote":"127.0.0.1:59414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "}
{"level":"info","ts":"2026-03-20T10:14:44.503942Z","caller":"traceutil/trace.go:171","msg":"trace[280481167] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:569; }","duration":"553.54125ms","start":"2026-03-20T10:14:43.950383Z","end":"2026-03-20T10:14:44.503924Z","steps":["trace[280481167] 'range keys from in-memory index tree'  (duration: 553.279434ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.504383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.950366Z","time spent":"554.002069ms","remote":"127.0.0.1:59414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "}
{"level":"warn","ts":"2026-03-20T10:14:44.504371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.936381Z","time spent":"567.969054ms","remote":"127.0.0.1:59392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:14:44.504704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.212904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.50474Z","caller":"traceutil/trace.go:171","msg":"trace[1270751878] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:569; }","duration":"554.262005ms","start":"2026-03-20T10:14:43.950467Z","end":"2026-03-20T10:14:44.504729Z","steps":["trace[1270751878] 'count revisions from in-memory index tree'  (duration: 554.178034ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.504763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.950463Z","time spent":"554.293416ms","remote":"127.0.0.1:59414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"info","ts":"2026-03-20T10:14:44.504807Z","caller":"traceutil/trace.go:171","msg":"trace[2028845228] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"542.48109ms","start":"2026-03-20T10:14:43.962312Z","end":"2026-03-20T10:14:44.504793Z","steps":["trace[2028845228] 'process raft request'  (duration: 538.477063ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.504895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.962299Z","time spent":"542.540601ms","remote":"127.0.0.1:37572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" value_size:187346 >> failure:<>"}
{"level":"info","ts":"2026-03-20T10:14:44.511418Z","caller":"traceutil/trace.go:171","msg":"trace[1404864517] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"548.655064ms","start":"2026-03-20T10:14:43.962745Z","end":"2026-03-20T10:14:44.5114Z","steps":["trace[1404864517] 'process raft request'  (duration: 548.178763ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.511539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.962718Z","time spent":"548.742586ms","remote":"127.0.0.1:37572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" mod_revision:569 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" value_size:188139 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" > >"}
{"level":"info","ts":"2026-03-20T10:14:44.51166Z","caller":"traceutil/trace.go:171","msg":"trace[1877028952] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:587; }","duration":"544.555585ms","start":"2026-03-20T10:14:43.966765Z","end":"2026-03-20T10:14:44.51132Z","steps":["trace[1877028952] 'read index received'  (duration: 533.798421ms)","trace[1877028952] 'applied index is now lower than readState.Index'  (duration: 10.756034ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:44.511744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.965104ms","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:5"}
{"level":"warn","ts":"2026-03-20T10:14:44.511914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.061435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.511936Z","caller":"traceutil/trace.go:171","msg":"trace[1959742376] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:571; }","duration":"545.086816ms","start":"2026-03-20T10:14:43.966841Z","end":"2026-03-20T10:14:44.511928Z","steps":["trace[1959742376] 'agreement among raft nodes before linearized reading'  (duration: 545.050175ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.511959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.966821Z","time spent":"545.131918ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 "}
{"level":"warn","ts":"2026-03-20T10:14:44.512065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.27229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:14:44.512102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.522587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.512104Z","caller":"traceutil/trace.go:171","msg":"trace[1778317689] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:571; }","duration":"499.315041ms","start":"2026-03-20T10:14:44.012777Z","end":"2026-03-20T10:14:44.512092Z","steps":["trace[1778317689] 'agreement among raft nodes before linearized reading'  (duration: 499.248499ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:44.512122Z","caller":"traceutil/trace.go:171","msg":"trace[290625791] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:571; }","duration":"500.587508ms","start":"2026-03-20T10:14:44.011528Z","end":"2026-03-20T10:14:44.512116Z","steps":["trace[290625791] 'agreement among raft nodes before linearized reading'  (duration: 500.557297ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.512135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:44.012724Z","time spent":"499.402332ms","remote":"127.0.0.1:59436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "}
{"level":"warn","ts":"2026-03-20T10:14:44.51218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.735381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.512197Z","caller":"traceutil/trace.go:171","msg":"trace[2086618047] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:571; }","duration":"500.752572ms","start":"2026-03-20T10:14:44.01144Z","end":"2026-03-20T10:14:44.512192Z","steps":["trace[2086618047] 'agreement among raft nodes before linearized reading'  (duration: 500.711641ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.512214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:44.011382Z","time spent":"500.828083ms","remote":"127.0.0.1:59436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "}
{"level":"warn","ts":"2026-03-20T10:14:44.512304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.197186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.512321Z","caller":"traceutil/trace.go:171","msg":"trace[579637763] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:571; }","duration":"515.231286ms","start":"2026-03-20T10:14:43.997085Z","end":"2026-03-20T10:14:44.512316Z","steps":["trace[579637763] 'agreement among raft nodes before linearized reading'  (duration: 515.204836ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.512338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.997079Z","time spent":"515.254717ms","remote":"127.0.0.1:59434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 "}
{"level":"warn","ts":"2026-03-20T10:14:44.512452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.599354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.512472Z","caller":"traceutil/trace.go:171","msg":"trace[974816323] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:571; }","duration":"515.629016ms","start":"2026-03-20T10:14:43.996835Z","end":"2026-03-20T10:14:44.512464Z","steps":["trace[974816323] 'agreement among raft nodes before linearized reading'  (duration: 515.577004ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.512489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.996724Z","time spent":"515.760728ms","remote":"127.0.0.1:59434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 "}
{"level":"warn","ts":"2026-03-20T10:14:44.512555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.955656ms","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:44.512567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.739438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.512583Z","caller":"traceutil/trace.go:171","msg":"trace[2114341017] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:571; }","duration":"130.001388ms","start":"2026-03-20T10:14:44.382574Z","end":"2026-03-20T10:14:44.512575Z","steps":["trace[2114341017] 'agreement among raft nodes before linearized reading'  (duration: 129.962457ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:44.512588Z","caller":"traceutil/trace.go:171","msg":"trace[629912454] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:571; }","duration":"515.773668ms","start":"2026-03-20T10:14:43.996808Z","end":"2026-03-20T10:14:44.512581Z","steps":["trace[629912454] 'agreement among raft nodes before linearized reading'  (duration: 515.742087ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.512637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.996799Z","time spent":"515.832859ms","remote":"127.0.0.1:59434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:14:44.512712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.523189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.512729Z","caller":"traceutil/trace.go:171","msg":"trace[1612651362] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:571; }","duration":"530.5521ms","start":"2026-03-20T10:14:43.982171Z","end":"2026-03-20T10:14:44.512723Z","steps":["trace[1612651362] 'agreement among raft nodes before linearized reading'  (duration: 530.52558ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.512738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.194359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"}
{"level":"warn","ts":"2026-03-20T10:14:44.512746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.982163Z","time spent":"530.578441ms","remote":"127.0.0.1:59430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 "}
{"level":"info","ts":"2026-03-20T10:14:44.512763Z","caller":"traceutil/trace.go:171","msg":"trace[1258212992] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:571; }","duration":"214.25595ms","start":"2026-03-20T10:14:44.298498Z","end":"2026-03-20T10:14:44.512754Z","steps":["trace[1258212992] 'agreement among raft nodes before linearized reading'  (duration: 214.188308ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.512833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.131122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.512853Z","caller":"traceutil/trace.go:171","msg":"trace[953462082] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:571; }","duration":"531.161873ms","start":"2026-03-20T10:14:43.981684Z","end":"2026-03-20T10:14:44.512846Z","steps":["trace[953462082] 'agreement among raft nodes before linearized reading'  (duration: 531.134802ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.51287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.981679Z","time spent":"531.186623ms","remote":"127.0.0.1:59430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:14:44.512894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.69234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"}
{"level":"info","ts":"2026-03-20T10:14:44.512919Z","caller":"traceutil/trace.go:171","msg":"trace[1327479093] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:571; }","duration":"414.73356ms","start":"2026-03-20T10:14:44.098178Z","end":"2026-03-20T10:14:44.512912Z","steps":["trace[1327479093] 'agreement among raft nodes before linearized reading'  (duration: 414.663329ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.512941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:44.098166Z","time spent":"414.769092ms","remote":"127.0.0.1:37572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5200,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "}
{"level":"warn","ts":"2026-03-20T10:14:44.512946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.271976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.512963Z","caller":"traceutil/trace.go:171","msg":"trace[692735032] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:571; }","duration":"531.306866ms","start":"2026-03-20T10:14:43.981651Z","end":"2026-03-20T10:14:44.512958Z","steps":["trace[692735032] 'agreement among raft nodes before linearized reading'  (duration: 531.277966ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.512982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.981644Z","time spent":"531.333757ms","remote":"127.0.0.1:59430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 "}
{"level":"warn","ts":"2026-03-20T10:14:44.513038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.785411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:14:44.513052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.439312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.513062Z","caller":"traceutil/trace.go:171","msg":"trace[986384682] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:571; }","duration":"482.831402ms","start":"2026-03-20T10:14:44.030223Z","end":"2026-03-20T10:14:44.513054Z","steps":["trace[986384682] 'agreement among raft nodes before linearized reading'  (duration: 482.793322ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:44.513069Z","caller":"traceutil/trace.go:171","msg":"trace[2123864443] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:571; }","duration":"544.469373ms","start":"2026-03-20T10:14:43.968595Z","end":"2026-03-20T10:14:44.513064Z","steps":["trace[2123864443] 'agreement among raft nodes before linearized reading'  (duration: 544.443002ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.513086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.968588Z","time spent":"544.493453ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 "}
{"level":"warn","ts":"2026-03-20T10:14:44.513085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:44.030206Z","time spent":"482.872653ms","remote":"127.0.0.1:59442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 "}
{"level":"warn","ts":"2026-03-20T10:14:44.513206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.512947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.513229Z","caller":"traceutil/trace.go:171","msg":"trace[859027277] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:571; }","duration":"483.551558ms","start":"2026-03-20T10:14:44.02967Z","end":"2026-03-20T10:14:44.513221Z","steps":["trace[859027277] 'agreement among raft nodes before linearized reading'  (duration: 483.514997ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.513256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:44.029661Z","time spent":"483.586389ms","remote":"127.0.0.1:59442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:14:44.513347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.700721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:14:44.513368Z","caller":"traceutil/trace.go:171","msg":"trace[278162344] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:571; }","duration":"483.819603ms","start":"2026-03-20T10:14:44.029541Z","end":"2026-03-20T10:14:44.513361Z","steps":["trace[278162344] 'agreement among raft nodes before linearized reading'  (duration: 483.788682ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.513391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:44.029526Z","time spent":"483.857165ms","remote":"127.0.0.1:59442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 "}
{"level":"warn","ts":"2026-03-20T10:14:44.512141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:44.011497Z","time spent":"500.638569ms","remote":"127.0.0.1:59436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}
{"level":"info","ts":"2026-03-20T10:14:44.516419Z","caller":"traceutil/trace.go:171","msg":"trace[49169751] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:571; }","duration":"545.104987ms","start":"2026-03-20T10:14:43.966759Z","end":"2026-03-20T10:14:44.511864Z","steps":["trace[49169751] 'agreement among raft nodes before linearized reading'  (duration: 544.949913ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.516463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:43.966716Z","time spent":"549.723177ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"info","ts":"2026-03-20T10:14:44.943082Z","caller":"traceutil/trace.go:171","msg":"trace[997769268] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:591; }","duration":"244.746133ms","start":"2026-03-20T10:14:44.698311Z","end":"2026-03-20T10:14:44.943057Z","steps":["trace[997769268] 'read index received'  (duration: 229.995572ms)","trace[997769268] 'applied index is now lower than readState.Index'  (duration: 14.749561ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:44.943248Z","caller":"traceutil/trace.go:171","msg":"trace[275755729] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"333.988054ms","start":"2026-03-20T10:14:44.609162Z","end":"2026-03-20T10:14:44.94315Z","steps":["trace[275755729] 'process raft request'  (duration: 319.243033ms)","trace[275755729] 'compare'  (duration: 14.481716ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:44.943343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.000109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"}
{"level":"info","ts":"2026-03-20T10:14:44.943431Z","caller":"traceutil/trace.go:171","msg":"trace[483834023] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:574; }","duration":"245.127832ms","start":"2026-03-20T10:14:44.69828Z","end":"2026-03-20T10:14:44.943408Z","steps":["trace[483834023] 'agreement among raft nodes before linearized reading'  (duration: 244.882717ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:44.943699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:44.609127Z","time spent":"334.268161ms","remote":"127.0.0.1:37572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188471,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" mod_revision:570 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" value_size:188362 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" > >"}
{"level":"info","ts":"2026-03-20T10:14:48.763566Z","caller":"traceutil/trace.go:171","msg":"trace[971364838] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"381.739523ms","start":"2026-03-20T10:14:48.381799Z","end":"2026-03-20T10:14:48.763538Z","steps":["trace[971364838] 'read index received'  (duration: 381.645191ms)","trace[971364838] 'applied index is now lower than readState.Index'  (duration: 92.582µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:48.763577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:48.367186Z","time spent":"396.384132ms","remote":"127.0.0.1:37552","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:48.76372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.896647ms","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:48.763776Z","caller":"traceutil/trace.go:171","msg":"trace[1169050252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"381.983688ms","start":"2026-03-20T10:14:48.381776Z","end":"2026-03-20T10:14:48.76376Z","steps":["trace[1169050252] 'agreement among raft nodes before linearized reading'  (duration: 381.876386ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:48.763816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:48.381765Z","time spent":"382.044999ms","remote":"127.0.0.1:37496","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:48.764025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.578494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gpxrq\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-03-20T10:14:48.764071Z","caller":"traceutil/trace.go:171","msg":"trace[961996095] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gpxrq; range_end:; response_count:1; response_revision:587; }","duration":"241.675187ms","start":"2026-03-20T10:14:48.522384Z","end":"2026-03-20T10:14:48.764059Z","steps":["trace[961996095] 'agreement among raft nodes before linearized reading'  (duration: 241.513083ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:48.764176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.020451ms","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:48.764223Z","caller":"traceutil/trace.go:171","msg":"trace[1016437983] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:587; }","duration":"229.085283ms","start":"2026-03-20T10:14:48.535124Z","end":"2026-03-20T10:14:48.764209Z","steps":["trace[1016437983] 'agreement among raft nodes before linearized reading'  (duration: 228.93761ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:49.206519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.019881ms","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:49.206586Z","caller":"traceutil/trace.go:171","msg":"trace[909474702] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:587; }","duration":"658.120634ms","start":"2026-03-20T10:14:48.548449Z","end":"2026-03-20T10:14:49.206569Z","steps":["trace[909474702] 'agreement among raft nodes before linearized reading'  (duration: 215.59908ms)","trace[909474702] 'range keys from in-memory index tree'  (duration: 441.755858ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:49.206623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:48.548438Z","time spent":"658.177825ms","remote":"127.0.0.1:37746","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:14:49.206658Z","caller":"traceutil/trace.go:171","msg":"trace[992645613] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"441.641525ms","start":"2026-03-20T10:14:48.764975Z","end":"2026-03-20T10:14:49.206616Z","steps":["trace[992645613] 'process raft request'  (duration: 404.487116ms)","trace[992645613] 'compare'  (duration: 36.916923ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:49.206962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:48.764956Z","time spent":"441.823359ms","remote":"127.0.0.1:37552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.19.213.133\" mod_revision:511 > success:<request_put:<key:\"/registry/masterleases/199.19.213.133\" value_size:67 lease:6738120661943889406 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.133\" > >"}
{"level":"info","ts":"2026-03-20T10:14:49.441435Z","caller":"traceutil/trace.go:171","msg":"trace[2122968719] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"232.319003ms","start":"2026-03-20T10:14:49.209019Z","end":"2026-03-20T10:14:49.441338Z","steps":["trace[2122968719] 'read index received'  (duration: 231.959535ms)","trace[2122968719] 'applied index is now lower than readState.Index'  (duration: 358.198µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:49.44156Z","caller":"traceutil/trace.go:171","msg":"trace[830556998] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"673.377105ms","start":"2026-03-20T10:14:48.768147Z","end":"2026-03-20T10:14:49.441524Z","steps":["trace[830556998] 'process raft request'  (duration: 672.909235ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:49.441845Z","caller":"traceutil/trace.go:171","msg":"trace[1561753371] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"663.194374ms","start":"2026-03-20T10:14:48.778608Z","end":"2026-03-20T10:14:49.441802Z","steps":["trace[1561753371] 'process raft request'  (duration: 662.639232ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:49.441932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.877305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-03-20T10:14:49.44199Z","caller":"traceutil/trace.go:171","msg":"trace[1360482459] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:590; }","duration":"233.001988ms","start":"2026-03-20T10:14:49.208972Z","end":"2026-03-20T10:14:49.441974Z","steps":["trace[1360482459] 'agreement among raft nodes before linearized reading'  (duration: 232.815204ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:49.442045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:48.778594Z","time spent":"663.341697ms","remote":"127.0.0.1:37688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-gpxrq\" mod_revision:506 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-gpxrq\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-gpxrq\" > >"}
{"level":"warn","ts":"2026-03-20T10:14:49.442346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:48.768121Z","time spent":"673.496328ms","remote":"127.0.0.1:37746","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:580 > 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:49.459279Z","caller":"traceutil/trace.go:171","msg":"trace[12076520] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"249.100149ms","start":"2026-03-20T10:14:49.210151Z","end":"2026-03-20T10:14:49.459252Z","steps":["trace[12076520] 'process raft request'  (duration: 248.890624ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:49.459645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.786913ms","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:49.459808Z","caller":"traceutil/trace.go:171","msg":"trace[182094266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:591; }","duration":"158.913736ms","start":"2026-03-20T10:14:49.30079Z","end":"2026-03-20T10:14:49.459704Z","steps":["trace[182094266] 'agreement among raft nodes before linearized reading'  (duration: 158.579009ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:49.459911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.715779ms","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:14:49.459987Z","caller":"traceutil/trace.go:171","msg":"trace[226249722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:591; }","duration":"213.830021ms","start":"2026-03-20T10:14:49.246134Z","end":"2026-03-20T10:14:49.459964Z","steps":["trace[226249722] 'agreement among raft nodes before linearized reading'  (duration: 213.705528ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:49.460121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.585389ms","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:49.460154Z","caller":"traceutil/trace.go:171","msg":"trace[1940928989] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:591; }","duration":"153.024998ms","start":"2026-03-20T10:14:49.30712Z","end":"2026-03-20T10:14:49.460145Z","steps":["trace[1940928989] 'agreement among raft nodes before linearized reading'  (duration: 152.462596ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:14:50.717826Z","caller":"traceutil/trace.go:171","msg":"trace[1313447687] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"333.920222ms","start":"2026-03-20T10:14:50.383872Z","end":"2026-03-20T10:14:50.717792Z","steps":["trace[1313447687] 'read index received'  (duration: 328.973195ms)","trace[1313447687] 'applied index is now lower than readState.Index'  (duration: 4.945437ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:50.718028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.124427ms","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:50.718064Z","caller":"traceutil/trace.go:171","msg":"trace[1023077013] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"334.24748ms","start":"2026-03-20T10:14:50.383806Z","end":"2026-03-20T10:14:50.718054Z","steps":["trace[1023077013] 'agreement among raft nodes before linearized reading'  (duration: 334.115177ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:50.7181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:50.38378Z","time spent":"334.311231ms","remote":"127.0.0.1:37508","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:14:50.71835Z","caller":"traceutil/trace.go:171","msg":"trace[1230949929] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"917.058256ms","start":"2026-03-20T10:14:49.801281Z","end":"2026-03-20T10:14:50.718339Z","steps":["trace[1230949929] 'process raft request'  (duration: 911.595358ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:50.718449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:49.801261Z","time spent":"917.114908ms","remote":"127.0.0.1:37746","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:518 > 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:51.964846Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492698798665233,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:14:52.46535Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492698798665233,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:14:52.592168Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.139622567s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T10:14:52.592641Z","caller":"traceutil/trace.go:171","msg":"trace[1617175643] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"1.128187538s","start":"2026-03-20T10:14:51.464412Z","end":"2026-03-20T10:14:52.592599Z","steps":["trace[1617175643] 'read index received'  (duration: 1.128067255s)","trace[1617175643] 'applied index is now lower than readState.Index'  (duration: 119.113µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:52.593444Z","caller":"traceutil/trace.go:171","msg":"trace[446396471] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.14021125s","start":"2026-03-20T10:14:51.452431Z","end":"2026-03-20T10:14:52.592642Z","steps":["trace[446396471] 'process raft request'  (duration: 1.139999815s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:52.593656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:51.452409Z","time spent":"1.141124419s","remote":"127.0.0.1:37746","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:589 > 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:52.594539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.130081669s","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:52.597168Z","caller":"traceutil/trace.go:171","msg":"trace[431540072] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:596; }","duration":"1.130309444s","start":"2026-03-20T10:14:51.464334Z","end":"2026-03-20T10:14:52.594643Z","steps":["trace[431540072] 'agreement among raft nodes before linearized reading'  (duration: 1.129876795s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:52.597269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:51.464288Z","time spent":"1.132955252s","remote":"127.0.0.1:37746","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:14:52.921127Z","caller":"traceutil/trace.go:171","msg":"trace[868361442] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"327.749029ms","start":"2026-03-20T10:14:52.593348Z","end":"2026-03-20T10:14:52.921097Z","steps":["trace[868361442] 'read index received'  (duration: 228.244814ms)","trace[868361442] 'applied index is now lower than readState.Index'  (duration: 99.503145ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:14:52.921253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.896503ms","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:52.92131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.423794508s","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:52.921347Z","caller":"traceutil/trace.go:171","msg":"trace[1689761524] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"1.42388518s","start":"2026-03-20T10:14:51.497452Z","end":"2026-03-20T10:14:52.921337Z","steps":["trace[1689761524] 'agreement among raft nodes before linearized reading'  (duration: 1.423738947s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:52.921398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:51.497424Z","time spent":"1.423965161s","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-20T10:14:52.92146Z","caller":"traceutil/trace.go:171","msg":"trace[36550622] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"439.130741ms","start":"2026-03-20T10:14:52.482314Z","end":"2026-03-20T10:14:52.921445Z","steps":["trace[36550622] 'process raft request'  (duration: 339.262759ms)","trace[36550622] 'compare'  (duration: 99.359391ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:14:52.921313Z","caller":"traceutil/trace.go:171","msg":"trace[1933159041] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"539.997434ms","start":"2026-03-20T10:14:52.381299Z","end":"2026-03-20T10:14:52.921296Z","steps":["trace[1933159041] 'agreement among raft nodes before linearized reading'  (duration: 539.865831ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:52.921553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:52.482297Z","time spent":"439.195823ms","remote":"127.0.0.1:37746","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:550 > 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:52.921586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:52.381272Z","time spent":"540.26149ms","remote":"127.0.0.1:37508","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:52.921696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.407284699s","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:52.921742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.407795499s","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:14:52.921782Z","caller":"traceutil/trace.go:171","msg":"trace[997456688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:597; }","duration":"1.407430592s","start":"2026-03-20T10:14:51.51433Z","end":"2026-03-20T10:14:52.921761Z","steps":["trace[997456688] 'agreement among raft nodes before linearized reading'  (duration: 1.407178237s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:52.921963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:51.51431Z","time spent":"1.407637646s","remote":"127.0.0.1:37746","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:14:52.921871Z","caller":"traceutil/trace.go:171","msg":"trace[1230526379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:597; }","duration":"1.407990544s","start":"2026-03-20T10:14:51.513843Z","end":"2026-03-20T10:14:52.921833Z","steps":["trace[1230526379] 'agreement among raft nodes before linearized reading'  (duration: 1.407662217s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:52.922658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:51.513821Z","time spent":"1.40824089s","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-20T10:14:52.928418Z","caller":"traceutil/trace.go:171","msg":"trace[2085198244] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"326.207245ms","start":"2026-03-20T10:14:52.602183Z","end":"2026-03-20T10:14:52.92839Z","steps":["trace[2085198244] 'process raft request'  (duration: 326.052162ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:14:52.92857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:52.602156Z","time spent":"326.306377ms","remote":"127.0.0.1:37746","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:591 > 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:15:01.747897Z","caller":"traceutil/trace.go:171","msg":"trace[1109292897] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"135.271152ms","start":"2026-03-20T10:15:01.612605Z","end":"2026-03-20T10:15:01.747876Z","steps":["trace[1109292897] 'process raft request'  (duration: 135.040917ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:02.053993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.632099ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15961492698798665342 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cilium.io/ciliumnodes/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumnodes/instance\" value_size:1605 >> failure:<>>","response":"size:5"}
{"level":"info","ts":"2026-03-20T10:15:02.054072Z","caller":"traceutil/trace.go:171","msg":"trace[2023876536] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"303.030352ms","start":"2026-03-20T10:15:01.75103Z","end":"2026-03-20T10:15:02.054061Z","steps":["trace[2023876536] 'read index received'  (duration: 82.386723ms)","trace[2023876536] 'applied index is now lower than readState.Index'  (duration: 220.642869ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:15:02.054134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.098673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1668"}
{"level":"info","ts":"2026-03-20T10:15:02.054151Z","caller":"traceutil/trace.go:171","msg":"trace[1399321082] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:653; }","duration":"303.144664ms","start":"2026-03-20T10:15:01.750998Z","end":"2026-03-20T10:15:02.054143Z","steps":["trace[1399321082] 'agreement among raft nodes before linearized reading'  (duration: 303.090033ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:02.054175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:01.750984Z","time spent":"303.186815ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":1691,"request content":"key:\"/registry/cilium.io/ciliumnodes/instance\" "}
{"level":"info","ts":"2026-03-20T10:15:02.054204Z","caller":"traceutil/trace.go:171","msg":"trace[1219411965] transaction","detail":"{read_only:false; number_of_response:0; response_revision:653; }","duration":"441.256058ms","start":"2026-03-20T10:15:01.612923Z","end":"2026-03-20T10:15:02.054179Z","steps":["trace[1219411965] 'process raft request'  (duration: 220.390803ms)","trace[1219411965] 'compare'  (duration: 220.580918ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:15:02.054307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:01.612911Z","time spent":"441.34675ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumnodes/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumnodes/instance\" value_size:1605 >> failure:<>"}
{"level":"info","ts":"2026-03-20T10:15:02.176797Z","caller":"traceutil/trace.go:171","msg":"trace[1668954244] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"121.37315ms","start":"2026-03-20T10:15:02.055403Z","end":"2026-03-20T10:15:02.176776Z","steps":["trace[1668954244] 'read index received'  (duration: 121.145745ms)","trace[1668954244] 'applied index is now lower than readState.Index'  (duration: 226.125µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:15:02.176975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.549304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1887"}
{"level":"info","ts":"2026-03-20T10:15:02.17704Z","caller":"traceutil/trace.go:171","msg":"trace[321783757] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:654; }","duration":"121.665706ms","start":"2026-03-20T10:15:02.055359Z","end":"2026-03-20T10:15:02.177025Z","steps":["trace[321783757] 'agreement among raft nodes before linearized reading'  (duration: 121.508303ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:02.177183Z","caller":"traceutil/trace.go:171","msg":"trace[525763252] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"419.498514ms","start":"2026-03-20T10:15:01.757673Z","end":"2026-03-20T10:15:02.177172Z","steps":["trace[525763252] 'process raft request'  (duration: 418.961393ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:02.177275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:01.757655Z","time spent":"419.552005ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1872,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumnodes/instance\" mod_revision:653 > success:<request_put:<key:\"/registry/cilium.io/ciliumnodes/instance\" value_size:1824 >> failure:<request_range:<key:\"/registry/cilium.io/ciliumnodes/instance\" > >"}
{"level":"info","ts":"2026-03-20T10:15:02.852542Z","caller":"traceutil/trace.go:171","msg":"trace[1690404300] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"166.270726ms","start":"2026-03-20T10:15:02.686231Z","end":"2026-03-20T10:15:02.852502Z","steps":["trace[1690404300] 'read index received'  (duration: 118.777783ms)","trace[1690404300] 'applied index is now lower than readState.Index'  (duration: 47.490943ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:15:02.852574Z","caller":"traceutil/trace.go:171","msg":"trace[151407308] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"172.936222ms","start":"2026-03-20T10:15:02.679583Z","end":"2026-03-20T10:15:02.852519Z","steps":["trace[151407308] 'process raft request'  (duration: 125.439629ms)","trace[151407308] 'compare'  (duration: 47.301239ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:15:02.85284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.572903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:2250"}
{"level":"info","ts":"2026-03-20T10:15:02.853795Z","caller":"traceutil/trace.go:171","msg":"trace[1333000096] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:657; }","duration":"166.710236ms","start":"2026-03-20T10:15:02.686202Z","end":"2026-03-20T10:15:02.852912Z","steps":["trace[1333000096] 'agreement among raft nodes before linearized reading'  (duration: 166.40543ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:03.299872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.606754ms","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:15:03.299943Z","caller":"traceutil/trace.go:171","msg":"trace[404062625] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"320.879818ms","start":"2026-03-20T10:15:02.979046Z","end":"2026-03-20T10:15:03.299926Z","steps":["trace[404062625] 'process raft request'  (duration: 314.05248ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:03.299989Z","caller":"traceutil/trace.go:171","msg":"trace[172752467] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:659; }","duration":"201.743897ms","start":"2026-03-20T10:15:03.098231Z","end":"2026-03-20T10:15:03.299975Z","steps":["trace[172752467] 'range keys from in-memory index tree'  (duration: 201.590974ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:03.300068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:02.979034Z","time spent":"320.957371ms","remote":"127.0.0.1:37746","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:649 > 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:15:03.300187Z","caller":"traceutil/trace.go:171","msg":"trace[1456951847] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:680; }","duration":"320.564642ms","start":"2026-03-20T10:15:02.979615Z","end":"2026-03-20T10:15:03.30018Z","steps":["trace[1456951847] 'read index received'  (duration: 16.857387ms)","trace[1456951847] 'applied index is now lower than readState.Index'  (duration: 303.706465ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:15:03.300285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.669474ms","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:15:03.300305Z","caller":"traceutil/trace.go:171","msg":"trace[1224695755] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:661; }","duration":"320.711885ms","start":"2026-03-20T10:15:02.979585Z","end":"2026-03-20T10:15:03.300297Z","steps":["trace[1224695755] 'agreement among raft nodes before linearized reading'  (duration: 320.623253ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:03.300276Z","caller":"traceutil/trace.go:171","msg":"trace[96431481] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"319.265223ms","start":"2026-03-20T10:15:02.980966Z","end":"2026-03-20T10:15:03.300231Z","steps":["trace[96431481] 'process raft request'  (duration: 318.929345ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:03.300332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:02.979573Z","time spent":"320.753616ms","remote":"127.0.0.1:37746","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:15:03.30048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:02.980939Z","time spent":"319.436557ms","remote":"127.0.0.1:37746","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:651 > 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:15:03.343971Z","caller":"traceutil/trace.go:171","msg":"trace[591193581] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"136.165791ms","start":"2026-03-20T10:15:03.207791Z","end":"2026-03-20T10:15:03.343956Z","steps":["trace[591193581] 'process raft request'  (duration: 136.017198ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:05.069922Z","caller":"traceutil/trace.go:171","msg":"trace[754420283] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"386.769522ms","start":"2026-03-20T10:15:04.683128Z","end":"2026-03-20T10:15:05.069898Z","steps":["trace[754420283] 'process raft request'  (duration: 386.634059ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:05.070067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:04.683111Z","time spent":"386.882085ms","remote":"127.0.0.1:37746","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:656 > 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:15:05.586156Z","caller":"traceutil/trace.go:171","msg":"trace[412361480] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:687; }","duration":"587.09461ms","start":"2026-03-20T10:15:04.999039Z","end":"2026-03-20T10:15:05.586133Z","steps":["trace[412361480] 'read index received'  (duration: 71.483415ms)","trace[412361480] 'applied index is now lower than readState.Index'  (duration: 515.610215ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:15:05.586387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.298921ms","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:15:05.586432Z","caller":"traceutil/trace.go:171","msg":"trace[1717743232] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:665; }","duration":"282.387472ms","start":"2026-03-20T10:15:05.30403Z","end":"2026-03-20T10:15:05.586417Z","steps":["trace[1717743232] 'agreement among raft nodes before linearized reading'  (duration: 282.233059ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:05.586423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.359415ms","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:15:05.586514Z","caller":"traceutil/trace.go:171","msg":"trace[608135806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:665; }","duration":"587.501089ms","start":"2026-03-20T10:15:04.998994Z","end":"2026-03-20T10:15:05.586495Z","steps":["trace[608135806] 'agreement among raft nodes before linearized reading'  (duration: 587.249653ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:05.586578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:04.998979Z","time spent":"587.59028ms","remote":"127.0.0.1:37746","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:15:05.586654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.410622ms","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:15:05.586727Z","caller":"traceutil/trace.go:171","msg":"trace[2103226333] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:665; }","duration":"230.523244ms","start":"2026-03-20T10:15:05.356185Z","end":"2026-03-20T10:15:05.586708Z","steps":["trace[2103226333] 'agreement among raft nodes before linearized reading'  (duration: 230.33634ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:05.586751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.648248ms","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:15:05.586787Z","caller":"traceutil/trace.go:171","msg":"trace[1688851148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:665; }","duration":"282.691389ms","start":"2026-03-20T10:15:05.304087Z","end":"2026-03-20T10:15:05.586778Z","steps":["trace[1688851148] 'agreement among raft nodes before linearized reading'  (duration: 282.603317ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:05.586922Z","caller":"traceutil/trace.go:171","msg":"trace[846809942] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"894.71837ms","start":"2026-03-20T10:15:04.691483Z","end":"2026-03-20T10:15:05.586201Z","steps":["trace[846809942] 'process raft request'  (duration: 894.465075ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:05.587015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:04.691452Z","time spent":"895.507128ms","remote":"127.0.0.1:37688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18698,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-gpxrq\" mod_revision:645 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-gpxrq\" value_size:18649 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-gpxrq\" > >"}
{"level":"info","ts":"2026-03-20T10:15:11.527303Z","caller":"traceutil/trace.go:171","msg":"trace[1088066591] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"359.53933ms","start":"2026-03-20T10:15:11.16774Z","end":"2026-03-20T10:15:11.527279Z","steps":["trace[1088066591] 'process raft request'  (duration: 359.415128ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:11.527448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:11.167706Z","time spent":"359.665142ms","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:648 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-20T10:15:12.482891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.672579ms","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:15:12.482906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.547577ms","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:15:12.482954Z","caller":"traceutil/trace.go:171","msg":"trace[185731313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:744; }","duration":"848.780582ms","start":"2026-03-20T10:15:11.634159Z","end":"2026-03-20T10:15:12.482939Z","steps":["trace[185731313] 'range keys from in-memory index tree'  (duration: 848.545266ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:12.482961Z","caller":"traceutil/trace.go:171","msg":"trace[1573618915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:744; }","duration":"848.602888ms","start":"2026-03-20T10:15:11.634342Z","end":"2026-03-20T10:15:12.482945Z","steps":["trace[1573618915] 'range keys from in-memory index tree'  (duration: 848.350813ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:12.482981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:11.634138Z","time spent":"848.837033ms","remote":"127.0.0.1:37746","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:15:12.482966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.461155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-20T10:15:12.482995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:11.634235Z","time spent":"848.752231ms","remote":"127.0.0.1:37746","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:15:12.483039Z","caller":"traceutil/trace.go:171","msg":"trace[154656500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:744; }","duration":"854.544047ms","start":"2026-03-20T10:15:11.62848Z","end":"2026-03-20T10:15:12.483024Z","steps":["trace[154656500] 'range keys from in-memory index tree'  (duration: 854.319702ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:12.483082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:11.628431Z","time spent":"854.643929ms","remote":"127.0.0.1:37746","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:15:12.483145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.8039ms","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:15:12.483178Z","caller":"traceutil/trace.go:171","msg":"trace[1847306792] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:744; }","duration":"841.853301ms","start":"2026-03-20T10:15:11.641314Z","end":"2026-03-20T10:15:12.483167Z","steps":["trace[1847306792] 'range keys from in-memory index tree'  (duration: 841.219187ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:12.483206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:11.641306Z","time spent":"841.893292ms","remote":"127.0.0.1:37746","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:15:12.879783Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492698798665514,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:15:13.302573Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.057209105s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T10:15:13.302889Z","caller":"traceutil/trace.go:171","msg":"trace[1354134497] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"1.057627984s","start":"2026-03-20T10:15:12.245235Z","end":"2026-03-20T10:15:13.302863Z","steps":["trace[1354134497] 'process raft request'  (duration: 1.057478321s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:13.303009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:12.245208Z","time spent":"1.057723686s","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5170,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:676 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5136 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-20T10:15:13.345142Z","caller":"traceutil/trace.go:171","msg":"trace[773354755] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"855.834385ms","start":"2026-03-20T10:15:12.489289Z","end":"2026-03-20T10:15:13.345124Z","steps":["trace[773354755] 'process raft request'  (duration: 855.779064ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:13.345278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:12.48928Z","time spent":"855.914947ms","remote":"127.0.0.1:37746","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:740 > 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:15:13.345429Z","caller":"traceutil/trace.go:171","msg":"trace[110316287] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"857.687856ms","start":"2026-03-20T10:15:12.487734Z","end":"2026-03-20T10:15:13.345422Z","steps":["trace[110316287] 'process raft request'  (duration: 857.246316ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:13.345427Z","caller":"traceutil/trace.go:171","msg":"trace[491273238] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"856.037369ms","start":"2026-03-20T10:15:12.489369Z","end":"2026-03-20T10:15:13.345406Z","steps":["trace[491273238] 'process raft request'  (duration: 855.727392ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:13.34547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:12.487713Z","time spent":"857.736366ms","remote":"127.0.0.1:37746","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:742 > 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:15:13.345542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:12.489352Z","time spent":"856.126402ms","remote":"127.0.0.1:37746","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:738 > 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:15:13.345741Z","caller":"traceutil/trace.go:171","msg":"trace[1958018436] linearizableReadLoop","detail":"{readStateIndex:775; appliedIndex:770; }","duration":"966.046352ms","start":"2026-03-20T10:15:12.379684Z","end":"2026-03-20T10:15:13.34573Z","steps":["trace[1958018436] 'read index received'  (duration: 923.151129ms)","trace[1958018436] 'applied index is now lower than readState.Index'  (duration: 42.894423ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:15:13.345837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"966.151535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:15:13.345864Z","caller":"traceutil/trace.go:171","msg":"trace[994124274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:749; }","duration":"966.201976ms","start":"2026-03-20T10:15:12.379653Z","end":"2026-03-20T10:15:13.345855Z","steps":["trace[994124274] 'agreement among raft nodes before linearized reading'  (duration: 966.161025ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:13.345883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:12.379638Z","time spent":"966.240677ms","remote":"127.0.0.1:37508","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:15:13.345946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.086921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:15:13.345969Z","caller":"traceutil/trace.go:171","msg":"trace[2067213047] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"856.570051ms","start":"2026-03-20T10:15:12.489393Z","end":"2026-03-20T10:15:13.345963Z","steps":["trace[2067213047] 'process raft request'  (duration: 855.947108ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:13.345983Z","caller":"traceutil/trace.go:171","msg":"trace[351781575] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:749; }","duration":"959.144423ms","start":"2026-03-20T10:15:12.386828Z","end":"2026-03-20T10:15:13.345973Z","steps":["trace[351781575] 'agreement among raft nodes before linearized reading'  (duration: 959.086491ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:13.346009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:12.48937Z","time spent":"856.617352ms","remote":"127.0.0.1:37746","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:739 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-20T10:15:13.346026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:12.386822Z","time spent":"959.184643ms","remote":"127.0.0.1:37862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:15:13.34628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.217424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-03-20T10:15:13.346312Z","caller":"traceutil/trace.go:171","msg":"trace[703768026] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:749; }","duration":"228.277686ms","start":"2026-03-20T10:15:13.118026Z","end":"2026-03-20T10:15:13.346304Z","steps":["trace[703768026] 'agreement among raft nodes before linearized reading'  (duration: 228.172394ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:15.746472Z","caller":"traceutil/trace.go:171","msg":"trace[1460023092] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"392.799434ms","start":"2026-03-20T10:15:15.353653Z","end":"2026-03-20T10:15:15.746452Z","steps":["trace[1460023092] 'process raft request'  (duration: 392.661021ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:15.746639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:15.353643Z","time spent":"392.924216ms","remote":"127.0.0.1:37746","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:746 > 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:15:17.146892Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.400476321s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T10:15:17.157142Z","caller":"traceutil/trace.go:171","msg":"trace[1649810688] linearizableReadLoop","detail":"{readStateIndex:783; appliedIndex:779; }","duration":"1.776025389s","start":"2026-03-20T10:15:15.381083Z","end":"2026-03-20T10:15:17.157108Z","steps":["trace[1649810688] 'read index received'  (duration: 365.360807ms)","trace[1649810688] 'applied index is now lower than readState.Index'  (duration: 1.410663052s)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:15:17.157289Z","caller":"traceutil/trace.go:171","msg":"trace[1826591957] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"1.802438714s","start":"2026-03-20T10:15:15.354837Z","end":"2026-03-20T10:15:17.157276Z","steps":["trace[1826591957] 'process raft request'  (duration: 1.792498908s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:17.157446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:15.354819Z","time spent":"1.802509825s","remote":"127.0.0.1:37746","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:748 > 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:15:17.157877Z","caller":"traceutil/trace.go:171","msg":"trace[641976356] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"1.802911614s","start":"2026-03-20T10:15:15.354949Z","end":"2026-03-20T10:15:17.157861Z","steps":["trace[641976356] 'process raft request'  (duration: 1.801920843s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:17.157953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:15.354922Z","time spent":"1.802995136s","remote":"127.0.0.1:37746","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:747 > 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:15:17.157948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.776844047s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:15:17.158017Z","caller":"traceutil/trace.go:171","msg":"trace[1853131331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:756; }","duration":"1.776945129s","start":"2026-03-20T10:15:15.381053Z","end":"2026-03-20T10:15:17.157998Z","steps":["trace[1853131331] 'agreement among raft nodes before linearized reading'  (duration: 1.776809437s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:17.15806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:15.381044Z","time spent":"1.777005601s","remote":"127.0.0.1:37508","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:15:17.158245Z","caller":"traceutil/trace.go:171","msg":"trace[874798451] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"1.801524855s","start":"2026-03-20T10:15:15.356705Z","end":"2026-03-20T10:15:17.15823Z","steps":["trace[874798451] 'process raft request'  (duration: 1.800357549s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:17.158274Z","caller":"traceutil/trace.go:171","msg":"trace[802398975] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"1.802094016s","start":"2026-03-20T10:15:15.356157Z","end":"2026-03-20T10:15:17.158251Z","steps":["trace[802398975] 'process raft request'  (duration: 1.800859069s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:17.158322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:15.356696Z","time spent":"1.801587816s","remote":"127.0.0.1:37746","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:749 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-20T10:15:17.158425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:15.356145Z","time spent":"1.802184749s","remote":"127.0.0.1:37746","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:750 > 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:15:17.177828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.745304732s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T10:15:17.177842Z","caller":"traceutil/trace.go:171","msg":"trace[367002184] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"1.226986018s","start":"2026-03-20T10:15:15.950832Z","end":"2026-03-20T10:15:17.177818Z","steps":["trace[367002184] 'process raft request'  (duration: 1.226792974s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:17.177833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.136177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T10:15:17.177901Z","caller":"traceutil/trace.go:171","msg":"trace[584502602] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:757; }","duration":"1.745396703s","start":"2026-03-20T10:15:15.432485Z","end":"2026-03-20T10:15:17.177882Z","steps":["trace[584502602] 'agreement among raft nodes before linearized reading'  (duration: 1.74526404s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:17.177922Z","caller":"traceutil/trace.go:171","msg":"trace[1547526907] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:757; }","duration":"265.289031ms","start":"2026-03-20T10:15:16.912618Z","end":"2026-03-20T10:15:17.177907Z","steps":["trace[1547526907] 'agreement among raft nodes before linearized reading'  (duration: 265.103517ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:17.177945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:15.432479Z","time spent":"1.745455044s","remote":"127.0.0.1:37988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:15:17.177968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.22158921s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-xdkf8\" ","response":"range_response_count:1 size:5086"}
{"level":"warn","ts":"2026-03-20T10:15:17.177997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:15.950807Z","time spent":"1.22709584s","remote":"127.0.0.1:37582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":811,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/coredns-7c96b6546b-v79p6.189e85295dfceccf\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-7c96b6546b-v79p6.189e85295dfceccf\" value_size:723 lease:6738120661943889648 >> failure:<>"}
{"level":"info","ts":"2026-03-20T10:15:17.17803Z","caller":"traceutil/trace.go:171","msg":"trace[1442061285] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-xdkf8; range_end:; response_count:1; response_revision:757; }","duration":"1.221678572s","start":"2026-03-20T10:15:15.956336Z","end":"2026-03-20T10:15:17.178015Z","steps":["trace[1442061285] 'agreement among raft nodes before linearized reading'  (duration: 1.221508218s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:17.178065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:15.956324Z","time spent":"1.221732923s","remote":"127.0.0.1:37688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5109,"request content":"key:\"/registry/pods/kube-system/coredns-67659f764b-xdkf8\" "}
{"level":"warn","ts":"2026-03-20T10:15:17.178333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.880263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T10:15:17.178395Z","caller":"traceutil/trace.go:171","msg":"trace[398323292] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:757; }","duration":"900.484616ms","start":"2026-03-20T10:15:16.2779Z","end":"2026-03-20T10:15:17.178384Z","steps":["trace[398323292] 'agreement among raft nodes before linearized reading'  (duration: 899.831702ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:17.178426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:16.277828Z","time spent":"900.587598ms","remote":"127.0.0.1:37950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":2,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "}
{"level":"info","ts":"2026-03-20T10:15:17.43666Z","caller":"traceutil/trace.go:171","msg":"trace[207042745] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"173.644117ms","start":"2026-03-20T10:15:17.262993Z","end":"2026-03-20T10:15:17.436637Z","steps":["trace[207042745] 'process raft request'  (duration: 173.506664ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:17.648674Z","caller":"traceutil/trace.go:171","msg":"trace[1713123228] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"385.131596ms","start":"2026-03-20T10:15:17.263526Z","end":"2026-03-20T10:15:17.648658Z","steps":["trace[1713123228] 'process raft request'  (duration: 385.090545ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:17.648784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:17.263507Z","time spent":"385.220058ms","remote":"127.0.0.1:37988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3888,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/coredns-67659f764b\" mod_revision:734 > success:<request_put:<key:\"/registry/replicasets/kube-system/coredns-67659f764b\" value_size:3828 >> failure:<request_range:<key:\"/registry/replicasets/kube-system/coredns-67659f764b\" > >"}
{"level":"info","ts":"2026-03-20T10:15:17.649004Z","caller":"traceutil/trace.go:171","msg":"trace[1062643461] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"385.938153ms","start":"2026-03-20T10:15:17.263059Z","end":"2026-03-20T10:15:17.648998Z","steps":["trace[1062643461] 'process raft request'  (duration: 385.462273ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:17.649033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:17.262972Z","time spent":"386.044556ms","remote":"127.0.0.1:37658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/kube-system/kube-dns\" mod_revision:733 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/kube-dns\" value_size:840 >> failure:<request_range:<key:\"/registry/services/endpoints/kube-system/kube-dns\" > >"}
{"level":"info","ts":"2026-03-20T10:15:17.821437Z","caller":"traceutil/trace.go:171","msg":"trace[401278491] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"164.235082ms","start":"2026-03-20T10:15:17.657165Z","end":"2026-03-20T10:15:17.8214Z","steps":["trace[401278491] 'process raft request'  (duration: 164.008427ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:25.340025Z","caller":"traceutil/trace.go:171","msg":"trace[1525049318] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"100.647349ms","start":"2026-03-20T10:15:25.239325Z","end":"2026-03-20T10:15:25.339973Z","steps":["trace[1525049318] 'process raft request'  (duration: 100.499496ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:36.786939Z","caller":"traceutil/trace.go:171","msg":"trace[1242556669] linearizableReadLoop","detail":"{readStateIndex:850; appliedIndex:849; }","duration":"404.370936ms","start":"2026-03-20T10:15:36.382547Z","end":"2026-03-20T10:15:36.786918Z","steps":["trace[1242556669] 'read index received'  (duration: 404.207422ms)","trace[1242556669] 'applied index is now lower than readState.Index'  (duration: 162.324µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:15:36.787016Z","caller":"traceutil/trace.go:171","msg":"trace[2078656705] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"743.516892ms","start":"2026-03-20T10:15:36.043449Z","end":"2026-03-20T10:15:36.786966Z","steps":["trace[2078656705] 'process raft request'  (duration: 743.337008ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:36.787052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.485458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:15:36.78713Z","caller":"traceutil/trace.go:171","msg":"trace[1919042594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:819; }","duration":"404.611201ms","start":"2026-03-20T10:15:36.382501Z","end":"2026-03-20T10:15:36.787112Z","steps":["trace[1919042594] 'agreement among raft nodes before linearized reading'  (duration: 404.501499ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:36.787174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:36.382476Z","time spent":"404.687922ms","remote":"127.0.0.1:37508","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:15:36.787188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:36.043416Z","time spent":"743.676765ms","remote":"127.0.0.1:37746","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:813 > 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:15:37.766487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.139802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-20T10:15:37.766549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.422938ms","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:15:37.76657Z","caller":"traceutil/trace.go:171","msg":"trace[1226640674] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:819; }","duration":"371.282976ms","start":"2026-03-20T10:15:37.395269Z","end":"2026-03-20T10:15:37.766552Z","steps":["trace[1226640674] 'range keys from in-memory index tree'  (duration: 370.917228ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:37.766599Z","caller":"traceutil/trace.go:171","msg":"trace[1929276948] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:819; }","duration":"365.51519ms","start":"2026-03-20T10:15:37.401069Z","end":"2026-03-20T10:15:37.766584Z","steps":["trace[1929276948] 'range keys from in-memory index tree'  (duration: 365.279816ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:37.766612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:37.395245Z","time spent":"371.357358ms","remote":"127.0.0.1:37746","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:15:37.766631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:37.401047Z","time spent":"365.576372ms","remote":"127.0.0.1:37746","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:15:37.766889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.796864ms","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:15:37.766954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.852385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T10:15:37.76699Z","caller":"traceutil/trace.go:171","msg":"trace[1599724853] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:819; }","duration":"906.937007ms","start":"2026-03-20T10:15:36.860041Z","end":"2026-03-20T10:15:37.766978Z","steps":["trace[1599724853] 'count revisions from in-memory index tree'  (duration: 906.762723ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:37.76703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:36.860016Z","time spent":"907.005708ms","remote":"127.0.0.1:37740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "}
{"level":"info","ts":"2026-03-20T10:15:37.766957Z","caller":"traceutil/trace.go:171","msg":"trace[196710012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:819; }","duration":"341.904857ms","start":"2026-03-20T10:15:37.425035Z","end":"2026-03-20T10:15:37.76694Z","steps":["trace[196710012] 'range keys from in-memory index tree'  (duration: 341.648541ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:37.767055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.085394ms","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:15:37.767114Z","caller":"traceutil/trace.go:171","msg":"trace[1663914532] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:819; }","duration":"338.188477ms","start":"2026-03-20T10:15:37.428911Z","end":"2026-03-20T10:15:37.7671Z","steps":["trace[1663914532] 'range keys from in-memory index tree'  (duration: 337.946921ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:37.767132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:37.425023Z","time spent":"342.07495ms","remote":"127.0.0.1:37746","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:15:37.767155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:37.428891Z","time spent":"338.252277ms","remote":"127.0.0.1:37746","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:15:38.066572Z","caller":"traceutil/trace.go:171","msg":"trace[1858314173] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"295.085648ms","start":"2026-03-20T10:15:37.771461Z","end":"2026-03-20T10:15:38.066547Z","steps":["trace[1858314173] 'process raft request'  (duration: 294.896614ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:38.066925Z","caller":"traceutil/trace.go:171","msg":"trace[2136263149] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"294.594757ms","start":"2026-03-20T10:15:37.772307Z","end":"2026-03-20T10:15:38.066902Z","steps":["trace[2136263149] 'process raft request'  (duration: 294.455914ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:38.066952Z","caller":"traceutil/trace.go:171","msg":"trace[228110807] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"295.382645ms","start":"2026-03-20T10:15:37.771542Z","end":"2026-03-20T10:15:38.066924Z","steps":["trace[228110807] 'process raft request'  (duration: 294.965786ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:38.941405Z","caller":"traceutil/trace.go:171","msg":"trace[1230374359] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"145.184138ms","start":"2026-03-20T10:15:38.796197Z","end":"2026-03-20T10:15:38.941381Z","steps":["trace[1230374359] 'process raft request'  (duration: 145.056425ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:40.216639Z","caller":"traceutil/trace.go:171","msg":"trace[1720726427] linearizableReadLoop","detail":"{readStateIndex:858; appliedIndex:857; }","duration":"145.324961ms","start":"2026-03-20T10:15:40.071284Z","end":"2026-03-20T10:15:40.216609Z","steps":["trace[1720726427] 'read index received'  (duration: 145.105346ms)","trace[1720726427] 'applied index is now lower than readState.Index'  (duration: 218.515µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:15:40.216689Z","caller":"traceutil/trace.go:171","msg":"trace[434358454] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"347.405377ms","start":"2026-03-20T10:15:39.869258Z","end":"2026-03-20T10:15:40.216663Z","steps":["trace[434358454] 'process raft request'  (duration: 347.194252ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:40.216929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.616427ms","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:15:40.216993Z","caller":"traceutil/trace.go:171","msg":"trace[62110764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:826; }","duration":"145.74235ms","start":"2026-03-20T10:15:40.071236Z","end":"2026-03-20T10:15:40.216978Z","steps":["trace[62110764] 'agreement among raft nodes before linearized reading'  (duration: 145.501585ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:40.216985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:39.869228Z","time spent":"347.641981ms","remote":"127.0.0.1:37746","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:820 > 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:15:40.217202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.7425ms","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:15:40.217384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.521885ms","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:15:40.217438Z","caller":"traceutil/trace.go:171","msg":"trace[925777447] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:826; }","duration":"145.611777ms","start":"2026-03-20T10:15:40.071809Z","end":"2026-03-20T10:15:40.217421Z","steps":["trace[925777447] 'agreement among raft nodes before linearized reading'  (duration: 145.453024ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:40.217404Z","caller":"traceutil/trace.go:171","msg":"trace[102275115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:826; }","duration":"145.975826ms","start":"2026-03-20T10:15:40.071406Z","end":"2026-03-20T10:15:40.217382Z","steps":["trace[102275115] 'agreement among raft nodes before linearized reading'  (duration: 145.533686ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:40.405799Z","caller":"traceutil/trace.go:171","msg":"trace[1515759948] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"183.332778ms","start":"2026-03-20T10:15:40.222438Z","end":"2026-03-20T10:15:40.405771Z","steps":["trace[1515759948] 'process raft request'  (duration: 161.878172ms)","trace[1515759948] 'compare'  (duration: 21.324573ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:15:40.416809Z","caller":"traceutil/trace.go:171","msg":"trace[1973483765] transaction","detail":"{read_only:false; response_revision:828; number_of_response:1; }","duration":"194.297326ms","start":"2026-03-20T10:15:40.222495Z","end":"2026-03-20T10:15:40.416793Z","steps":["trace[1973483765] 'process raft request'  (duration: 194.190204ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:40.417029Z","caller":"traceutil/trace.go:171","msg":"trace[1828299648] linearizableReadLoop","detail":"{readStateIndex:861; appliedIndex:858; }","duration":"173.258029ms","start":"2026-03-20T10:15:40.243743Z","end":"2026-03-20T10:15:40.417001Z","steps":["trace[1828299648] 'read index received'  (duration: 140.588128ms)","trace[1828299648] 'applied index is now lower than readState.Index'  (duration: 32.669131ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:15:40.417281Z","caller":"traceutil/trace.go:171","msg":"trace[1424806560] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"194.723905ms","start":"2026-03-20T10:15:40.222544Z","end":"2026-03-20T10:15:40.417268Z","steps":["trace[1424806560] 'process raft request'  (duration: 194.224064ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:40.417305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.540745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:15:40.417331Z","caller":"traceutil/trace.go:171","msg":"trace[482520322] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:829; }","duration":"173.621767ms","start":"2026-03-20T10:15:40.243702Z","end":"2026-03-20T10:15:40.417324Z","steps":["trace[482520322] 'agreement among raft nodes before linearized reading'  (duration: 173.555275ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:51.614023Z","caller":"traceutil/trace.go:171","msg":"trace[2068931385] linearizableReadLoop","detail":"{readStateIndex:944; appliedIndex:943; }","duration":"343.874016ms","start":"2026-03-20T10:15:51.269767Z","end":"2026-03-20T10:15:51.613641Z","steps":["trace[2068931385] 'read index received'  (duration: 343.645031ms)","trace[2068931385] 'applied index is now lower than readState.Index'  (duration: 227.895µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:15:51.614338Z","caller":"traceutil/trace.go:171","msg":"trace[1722852149] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"471.577934ms","start":"2026-03-20T10:15:51.142724Z","end":"2026-03-20T10:15:51.614302Z","steps":["trace[1722852149] 'process raft request'  (duration: 470.763405ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:51.614462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.667434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:15:51.614551Z","caller":"traceutil/trace.go:171","msg":"trace[1615228989] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:909; }","duration":"344.801608ms","start":"2026-03-20T10:15:51.269714Z","end":"2026-03-20T10:15:51.614516Z","steps":["trace[1615228989] 'agreement among raft nodes before linearized reading'  (duration: 344.46278ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:51.614504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:51.1427Z","time spent":"471.732757ms","remote":"127.0.0.1:37746","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:853 > 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:15:51.614716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:15:51.269693Z","time spent":"344.894819ms","remote":"127.0.0.1:35150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "}
{"level":"info","ts":"2026-03-20T10:15:52.449368Z","caller":"traceutil/trace.go:171","msg":"trace[1850260777] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"134.547655ms","start":"2026-03-20T10:15:52.314797Z","end":"2026-03-20T10:15:52.449345Z","steps":["trace[1850260777] 'process raft request'  (duration: 134.026813ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:52.572873Z","caller":"traceutil/trace.go:171","msg":"trace[34793790] linearizableReadLoop","detail":"{readStateIndex:946; appliedIndex:945; }","duration":"109.464556ms","start":"2026-03-20T10:15:52.463369Z","end":"2026-03-20T10:15:52.572833Z","steps":["trace[34793790] 'read index received'  (duration: 108.348461ms)","trace[34793790] 'applied index is now lower than readState.Index'  (duration: 1.114405ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:15:52.572921Z","caller":"traceutil/trace.go:171","msg":"trace[372387689] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"110.46623ms","start":"2026-03-20T10:15:52.462425Z","end":"2026-03-20T10:15:52.572891Z","steps":["trace[372387689] 'process raft request'  (duration: 109.227031ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:52.573172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.780603ms","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:15:52.573209Z","caller":"traceutil/trace.go:171","msg":"trace[672804990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:911; }","duration":"109.869246ms","start":"2026-03-20T10:15:52.463327Z","end":"2026-03-20T10:15:52.573197Z","steps":["trace[672804990] 'agreement among raft nodes before linearized reading'  (duration: 109.674021ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:52.573213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.02439ms","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:15:52.573256Z","caller":"traceutil/trace.go:171","msg":"trace[1402384760] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:911; }","duration":"104.123723ms","start":"2026-03-20T10:15:52.469118Z","end":"2026-03-20T10:15:52.573242Z","steps":["trace[1402384760] 'agreement among raft nodes before linearized reading'  (duration: 103.943358ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:53.868324Z","caller":"traceutil/trace.go:171","msg":"trace[1723095573] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"242.474346ms","start":"2026-03-20T10:15:53.625821Z","end":"2026-03-20T10:15:53.868296Z","steps":["trace[1723095573] 'process raft request'  (duration: 242.311342ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:54.579804Z","caller":"traceutil/trace.go:171","msg":"trace[2058881972] linearizableReadLoop","detail":"{readStateIndex:951; appliedIndex:950; }","duration":"198.287686ms","start":"2026-03-20T10:15:54.381489Z","end":"2026-03-20T10:15:54.579777Z","steps":["trace[2058881972] 'read index received'  (duration: 186.939354ms)","trace[2058881972] 'applied index is now lower than readState.Index'  (duration: 11.346462ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:15:54.579921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.44339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:15:54.57998Z","caller":"traceutil/trace.go:171","msg":"trace[1339174554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:915; }","duration":"198.545992ms","start":"2026-03-20T10:15:54.381418Z","end":"2026-03-20T10:15:54.579964Z","steps":["trace[1339174554] 'agreement among raft nodes before linearized reading'  (duration: 198.45118ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:54.580089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.38621ms","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:15:54.58013Z","caller":"traceutil/trace.go:171","msg":"trace[846598863] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:915; }","duration":"127.474322ms","start":"2026-03-20T10:15:54.452645Z","end":"2026-03-20T10:15:54.58012Z","steps":["trace[846598863] 'agreement among raft nodes before linearized reading'  (duration: 127.274077ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:10.03407Z","caller":"traceutil/trace.go:171","msg":"trace[226260898] linearizableReadLoop","detail":"{readStateIndex:1016; appliedIndex:1015; }","duration":"100.847957ms","start":"2026-03-20T10:16:09.933183Z","end":"2026-03-20T10:16:10.034031Z","steps":["trace[226260898] 'read index received'  (duration: 100.646782ms)","trace[226260898] 'applied index is now lower than readState.Index'  (duration: 199.975µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:16:10.034358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.151004ms","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:16:10.034401Z","caller":"traceutil/trace.go:171","msg":"trace[1034559794] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:976; }","duration":"101.242376ms","start":"2026-03-20T10:16:09.933147Z","end":"2026-03-20T10:16:10.034389Z","steps":["trace[1034559794] 'agreement among raft nodes before linearized reading'  (duration: 101.024011ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:10.035423Z","caller":"traceutil/trace.go:171","msg":"trace[322149068] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"156.983843ms","start":"2026-03-20T10:16:09.878423Z","end":"2026-03-20T10:16:10.035407Z","steps":["trace[322149068] 'process raft request'  (duration: 155.488168ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:10.196764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.766783ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15961492698798666087 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:962 > 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:16:10.196872Z","caller":"traceutil/trace.go:171","msg":"trace[1184214887] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"157.950605ms","start":"2026-03-20T10:16:10.038909Z","end":"2026-03-20T10:16:10.19686Z","steps":["trace[1184214887] 'process raft request'  (duration: 48.027298ms)","trace[1184214887] 'compare'  (duration: 109.659311ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:16:10.19718Z","caller":"traceutil/trace.go:171","msg":"trace[715833649] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"153.726268ms","start":"2026-03-20T10:16:10.043427Z","end":"2026-03-20T10:16:10.197153Z","steps":["trace[715833649] 'process raft request'  (duration: 153.547294ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:10.197193Z","caller":"traceutil/trace.go:171","msg":"trace[1874552889] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"153.913882ms","start":"2026-03-20T10:16:10.043239Z","end":"2026-03-20T10:16:10.197153Z","steps":["trace[1874552889] 'process raft request'  (duration: 153.605475ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:10.197239Z","caller":"traceutil/trace.go:171","msg":"trace[264913521] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"148.248792ms","start":"2026-03-20T10:16:10.048983Z","end":"2026-03-20T10:16:10.197232Z","steps":["trace[264913521] 'process raft request'  (duration: 148.112189ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:10.879808Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492698798666086,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-20T10:16:10.926311Z","caller":"traceutil/trace.go:171","msg":"trace[118698991] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1020; }","duration":"547.298961ms","start":"2026-03-20T10:16:10.378994Z","end":"2026-03-20T10:16:10.926293Z","steps":["trace[118698991] 'read index received'  (duration: 547.194139ms)","trace[118698991] 'applied index is now lower than readState.Index'  (duration: 104.102µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:16:10.926391Z","caller":"traceutil/trace.go:171","msg":"trace[1242247406] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"571.54604ms","start":"2026-03-20T10:16:10.354838Z","end":"2026-03-20T10:16:10.926384Z","steps":["trace[1242247406] 'process raft request'  (duration: 571.303005ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:10.926476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:10.354818Z","time spent":"571.592392ms","remote":"127.0.0.1:37582","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-4vmxd.189e853608cc85ed\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-4vmxd.189e853608cc85ed\" value_size:787 lease:6738120661943890229 >> failure:<>"}
{"level":"warn","ts":"2026-03-20T10:16:10.927383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.276905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:16:10.927438Z","caller":"traceutil/trace.go:171","msg":"trace[885643547] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:981; }","duration":"451.367287ms","start":"2026-03-20T10:16:10.476045Z","end":"2026-03-20T10:16:10.927412Z","steps":["trace[885643547] 'agreement among raft nodes before linearized reading'  (duration: 450.667281ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:10.927461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:10.476014Z","time spent":"451.441729ms","remote":"127.0.0.1:37508","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:16:10.927619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.624372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:16:10.927649Z","caller":"traceutil/trace.go:171","msg":"trace[1683281771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:981; }","duration":"548.683533ms","start":"2026-03-20T10:16:10.378949Z","end":"2026-03-20T10:16:10.927632Z","steps":["trace[1683281771] 'agreement among raft nodes before linearized reading'  (duration: 548.650982ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:10.927667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:10.378931Z","time spent":"548.730914ms","remote":"127.0.0.1:37496","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:16:10.928001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.627033ms","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:16:10.928079Z","caller":"traceutil/trace.go:171","msg":"trace[1847921891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:981; }","duration":"269.733055ms","start":"2026-03-20T10:16:10.658328Z","end":"2026-03-20T10:16:10.928062Z","steps":["trace[1847921891] 'agreement among raft nodes before linearized reading'  (duration: 269.379967ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:10.928129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.791186ms","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:16:10.92814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.296645ms","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:16:10.928196Z","caller":"traceutil/trace.go:171","msg":"trace[1786533639] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:981; }","duration":"269.412298ms","start":"2026-03-20T10:16:10.65877Z","end":"2026-03-20T10:16:10.928182Z","steps":["trace[1786533639] 'agreement among raft nodes before linearized reading'  (duration: 269.241084ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:10.92821Z","caller":"traceutil/trace.go:171","msg":"trace[1889128539] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:981; }","duration":"269.906669ms","start":"2026-03-20T10:16:10.658269Z","end":"2026-03-20T10:16:10.928176Z","steps":["trace[1889128539] 'agreement among raft nodes before linearized reading'  (duration: 269.52661ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:10.928128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.344666ms","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:16:10.92842Z","caller":"traceutil/trace.go:171","msg":"trace[835271707] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:981; }","duration":"269.694754ms","start":"2026-03-20T10:16:10.658713Z","end":"2026-03-20T10:16:10.928407Z","steps":["trace[835271707] 'agreement among raft nodes before linearized reading'  (duration: 269.296015ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:11.882494Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492698798666093,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:16:11.952495Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.018011853s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T10:16:11.97655Z","caller":"traceutil/trace.go:171","msg":"trace[163768705] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"1.04211203s","start":"2026-03-20T10:16:10.934401Z","end":"2026-03-20T10:16:11.976513Z","steps":["trace[163768705] 'process raft request'  (duration: 1.018309841s)","trace[163768705] 'compare'  (duration: 23.617875ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:16:11.976768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:10.934384Z","time spent":"1.042281514s","remote":"127.0.0.1:37746","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:965 > 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:16:12.027325Z","caller":"traceutil/trace.go:171","msg":"trace[1176821380] linearizableReadLoop","detail":"{readStateIndex:1025; appliedIndex:1021; }","duration":"645.422905ms","start":"2026-03-20T10:16:11.38188Z","end":"2026-03-20T10:16:12.027303Z","steps":["trace[1176821380] 'read index received'  (duration: 570.842024ms)","trace[1176821380] 'applied index is now lower than readState.Index'  (duration: 74.580111ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:16:12.027573Z","caller":"traceutil/trace.go:171","msg":"trace[610395043] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"1.093097586s","start":"2026-03-20T10:16:10.934468Z","end":"2026-03-20T10:16:12.027565Z","steps":["trace[610395043] 'process raft request'  (duration: 1.092681997s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:12.027666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:10.934449Z","time spent":"1.093150688s","remote":"127.0.0.1:37746","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:967 > 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:16:12.027792Z","caller":"traceutil/trace.go:171","msg":"trace[1965722197] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"1.093242189s","start":"2026-03-20T10:16:10.934544Z","end":"2026-03-20T10:16:12.027787Z","steps":["trace[1965722197] 'process raft request'  (duration: 1.092705817s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:12.027828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:10.934538Z","time spent":"1.093268731s","remote":"127.0.0.1:37746","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:966 > 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:16:12.027905Z","caller":"traceutil/trace.go:171","msg":"trace[331274704] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"1.093290471s","start":"2026-03-20T10:16:10.93461Z","end":"2026-03-20T10:16:12.0279Z","steps":["trace[331274704] 'process raft request'  (duration: 1.092666197s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:12.027936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:10.934589Z","time spent":"1.093329611s","remote":"127.0.0.1:37746","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:964 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-20T10:16:12.028045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.173973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:16:12.028072Z","caller":"traceutil/trace.go:171","msg":"trace[533197343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:985; }","duration":"646.238595ms","start":"2026-03-20T10:16:11.381826Z","end":"2026-03-20T10:16:12.028065Z","steps":["trace[533197343] 'agreement among raft nodes before linearized reading'  (duration: 646.188303ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:12.028091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:11.381803Z","time spent":"646.283695ms","remote":"127.0.0.1:37496","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:16:12.028435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.300779ms","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:16:12.028478Z","caller":"traceutil/trace.go:171","msg":"trace[307056583] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:985; }","duration":"423.3464ms","start":"2026-03-20T10:16:11.605124Z","end":"2026-03-20T10:16:12.028471Z","steps":["trace[307056583] 'agreement among raft nodes before linearized reading'  (duration: 423.283419ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:12.028501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:11.605108Z","time spent":"423.384ms","remote":"127.0.0.1:37630","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":"info","ts":"2026-03-20T10:16:13.460972Z","caller":"traceutil/trace.go:171","msg":"trace[1648725712] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"323.477215ms","start":"2026-03-20T10:16:13.137407Z","end":"2026-03-20T10:16:13.460885Z","steps":["trace[1648725712] 'process raft request'  (duration: 323.198259ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:13.461342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:13.137384Z","time spent":"323.708431ms","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:942 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-20T10:16:14.226455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.692302ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15961492698798666113 > lease_revoke:<id:5d829d0abce2b0e7>","response":"size:28"}
{"level":"info","ts":"2026-03-20T10:16:14.226584Z","caller":"traceutil/trace.go:171","msg":"trace[1103058919] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1032; }","duration":"845.447362ms","start":"2026-03-20T10:16:13.381116Z","end":"2026-03-20T10:16:14.226564Z","steps":["trace[1103058919] 'read index received'  (duration: 79.392373ms)","trace[1103058919] 'applied index is now lower than readState.Index'  (duration: 766.053489ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:16:14.226682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.551834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:16:14.22672Z","caller":"traceutil/trace.go:171","msg":"trace[1299053605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:993; }","duration":"845.625726ms","start":"2026-03-20T10:16:13.38108Z","end":"2026-03-20T10:16:14.226706Z","steps":["trace[1299053605] 'agreement among raft nodes before linearized reading'  (duration: 845.555575ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:14.226756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:13.381065Z","time spent":"845.684457ms","remote":"127.0.0.1:37508","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:16:14.726905Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492698798666115,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:16:14.890018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.578755ms","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:16:14.890029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.464182ms","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:16:14.89008Z","caller":"traceutil/trace.go:171","msg":"trace[1952367255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:994; }","duration":"855.730628ms","start":"2026-03-20T10:16:14.034336Z","end":"2026-03-20T10:16:14.890067Z","steps":["trace[1952367255] 'agreement among raft nodes before linearized reading'  (duration: 855.553164ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:14.890131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:14.034301Z","time spent":"855.80498ms","remote":"127.0.0.1:37746","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:16:14.890071Z","caller":"traceutil/trace.go:171","msg":"trace[366062750] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"821.6079ms","start":"2026-03-20T10:16:14.068436Z","end":"2026-03-20T10:16:14.890044Z","steps":["trace[366062750] 'process raft request'  (duration: 821.218351ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:14.890225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.474049ms","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:16:14.890194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.873872ms","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:16:14.890286Z","caller":"traceutil/trace.go:171","msg":"trace[1319203424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:994; }","duration":"909.555521ms","start":"2026-03-20T10:16:13.980716Z","end":"2026-03-20T10:16:14.890272Z","steps":["trace[1319203424] 'agreement among raft nodes before linearized reading'  (duration: 909.413587ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:14.890293Z","caller":"traceutil/trace.go:171","msg":"trace[1383925165] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:994; }","duration":"856.046266ms","start":"2026-03-20T10:16:14.034233Z","end":"2026-03-20T10:16:14.890279Z","steps":["trace[1383925165] 'agreement among raft nodes before linearized reading'  (duration: 855.742019ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:14.890316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:13.980632Z","time spent":"909.679123ms","remote":"127.0.0.1:37746","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:16:14.89033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:14.034206Z","time spent":"856.116047ms","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-20T10:16:14.890193Z","caller":"traceutil/trace.go:171","msg":"trace[109426765] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:994; }","duration":"855.597655ms","start":"2026-03-20T10:16:14.034499Z","end":"2026-03-20T10:16:14.890097Z","steps":["trace[109426765] 'agreement among raft nodes before linearized reading'  (duration: 855.37387ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:14.890524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:14.068418Z","time spent":"821.98257ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5958,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:974 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5924 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-20T10:16:14.890559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:14.034485Z","time spent":"856.056556ms","remote":"127.0.0.1:37746","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:16:14.890983Z","caller":"traceutil/trace.go:171","msg":"trace[474843770] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1034; }","duration":"663.223875ms","start":"2026-03-20T10:16:14.226609Z","end":"2026-03-20T10:16:14.889833Z","steps":["trace[474843770] 'read index received'  (duration: 662.945729ms)","trace[474843770] 'applied index is now lower than readState.Index'  (duration: 277.026µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:16:14.891413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.232645ms","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:16:14.891417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.564543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:16:14.891438Z","caller":"traceutil/trace.go:171","msg":"trace[556631808] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:994; }","duration":"653.295516ms","start":"2026-03-20T10:16:14.238137Z","end":"2026-03-20T10:16:14.891432Z","steps":["trace[556631808] 'agreement among raft nodes before linearized reading'  (duration: 653.221425ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:14.891556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:14.238095Z","time spent":"653.45603ms","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-20T10:16:14.895195Z","caller":"traceutil/trace.go:171","msg":"trace[911640432] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:994; }","duration":"667.376201ms","start":"2026-03-20T10:16:14.227798Z","end":"2026-03-20T10:16:14.895174Z","steps":["trace[911640432] 'agreement among raft nodes before linearized reading'  (duration: 663.551342ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:14.895262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:14.227776Z","time spent":"667.469263ms","remote":"127.0.0.1:37496","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:16:15.057747Z","caller":"traceutil/trace.go:171","msg":"trace[1039059752] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1035; }","duration":"155.811066ms","start":"2026-03-20T10:16:14.901918Z","end":"2026-03-20T10:16:15.057729Z","steps":["trace[1039059752] 'read index received'  (duration: 26.510512ms)","trace[1039059752] 'applied index is now lower than readState.Index'  (duration: 129.299964ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:16:15.057798Z","caller":"traceutil/trace.go:171","msg":"trace[1634675212] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"160.421002ms","start":"2026-03-20T10:16:14.897343Z","end":"2026-03-20T10:16:15.057764Z","steps":["trace[1634675212] 'process raft request'  (duration: 160.3249ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:15.057855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.929128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:16:15.057837Z","caller":"traceutil/trace.go:171","msg":"trace[223414693] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"158.286683ms","start":"2026-03-20T10:16:14.899527Z","end":"2026-03-20T10:16:15.057813Z","steps":["trace[223414693] 'process raft request'  (duration: 158.16317ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:15.05793Z","caller":"traceutil/trace.go:171","msg":"trace[56238710] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"158.190561ms","start":"2026-03-20T10:16:14.899731Z","end":"2026-03-20T10:16:15.057922Z","steps":["trace[56238710] 'process raft request'  (duration: 157.977206ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:15.057926Z","caller":"traceutil/trace.go:171","msg":"trace[905267562] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"161.713642ms","start":"2026-03-20T10:16:14.896186Z","end":"2026-03-20T10:16:15.057899Z","steps":["trace[905267562] 'process raft request'  (duration: 161.378264ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:15.057877Z","caller":"traceutil/trace.go:171","msg":"trace[1702703730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:999; }","duration":"156.00741ms","start":"2026-03-20T10:16:14.901863Z","end":"2026-03-20T10:16:15.057871Z","steps":["trace[1702703730] 'agreement among raft nodes before linearized reading'  (duration: 155.937139ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:17.11921Z","caller":"traceutil/trace.go:171","msg":"trace[427315920] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"182.650486ms","start":"2026-03-20T10:16:16.936533Z","end":"2026-03-20T10:16:17.119183Z","steps":["trace[427315920] 'process raft request'  (duration: 182.088233ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:17.370951Z","caller":"traceutil/trace.go:171","msg":"trace[1261300679] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"247.177704ms","start":"2026-03-20T10:16:17.123728Z","end":"2026-03-20T10:16:17.370906Z","steps":["trace[1261300679] 'process raft request'  (duration: 246.919218ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:17.678911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.172094ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15961492698798666133 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:996 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:16:17.679113Z","caller":"traceutil/trace.go:171","msg":"trace[1404923090] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"555.298505ms","start":"2026-03-20T10:16:17.123782Z","end":"2026-03-20T10:16:17.679081Z","steps":["trace[1404923090] 'process raft request'  (duration: 333.857215ms)","trace[1404923090] 'compare'  (duration: 220.98632ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:16:17.679184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:17.123763Z","time spent":"555.392327ms","remote":"127.0.0.1:37746","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:996 > 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:16:17.679716Z","caller":"traceutil/trace.go:171","msg":"trace[1300362049] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"555.563982ms","start":"2026-03-20T10:16:17.124137Z","end":"2026-03-20T10:16:17.679701Z","steps":["trace[1300362049] 'process raft request'  (duration: 554.900196ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:17.679777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:17.124129Z","time spent":"555.619033ms","remote":"127.0.0.1:37746","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:998 > 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:16:17.679752Z","caller":"traceutil/trace.go:171","msg":"trace[237625456] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1043; }","duration":"451.696734ms","start":"2026-03-20T10:16:17.22803Z","end":"2026-03-20T10:16:17.679726Z","steps":["trace[237625456] 'read index received'  (duration: 143.954532ms)","trace[237625456] 'applied index is now lower than readState.Index'  (duration: 307.740922ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:16:17.679801Z","caller":"traceutil/trace.go:171","msg":"trace[345957175] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"555.08505ms","start":"2026-03-20T10:16:17.124678Z","end":"2026-03-20T10:16:17.679763Z","steps":["trace[345957175] 'process raft request'  (duration: 554.891716ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:17.679986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:17.124644Z","time spent":"555.238274ms","remote":"127.0.0.1:37746","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:999 > 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:16:17.679991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.93241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T10:16:17.680064Z","caller":"traceutil/trace.go:171","msg":"trace[1381892790] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1005; }","duration":"452.066663ms","start":"2026-03-20T10:16:17.22798Z","end":"2026-03-20T10:16:17.680047Z","steps":["trace[1381892790] 'agreement among raft nodes before linearized reading'  (duration: 451.902579ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:17.680106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:17.227962Z","time spent":"452.134425ms","remote":"127.0.0.1:37688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "}
{"level":"warn","ts":"2026-03-20T10:16:17.680081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.090953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:16:17.680153Z","caller":"traceutil/trace.go:171","msg":"trace[717944817] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1005; }","duration":"299.217206ms","start":"2026-03-20T10:16:17.380923Z","end":"2026-03-20T10:16:17.68014Z","steps":["trace[717944817] 'agreement among raft nodes before linearized reading'  (duration: 299.065032ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:18.087447Z","caller":"traceutil/trace.go:171","msg":"trace[888564805] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"332.859122ms","start":"2026-03-20T10:16:17.754554Z","end":"2026-03-20T10:16:18.087413Z","steps":["trace[888564805] 'process raft request'  (duration: 259.727904ms)","trace[888564805] 'compare'  (duration: 72.76982ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:16:18.087757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:17.754515Z","time spent":"333.072387ms","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:992 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-20T10:16:24.371493Z","caller":"traceutil/trace.go:171","msg":"trace[1507623443] linearizableReadLoop","detail":"{readStateIndex:1101; appliedIndex:1100; }","duration":"263.687146ms","start":"2026-03-20T10:16:24.10778Z","end":"2026-03-20T10:16:24.371467Z","steps":["trace[1507623443] 'read index received'  (duration: 263.487961ms)","trace[1507623443] 'applied index is now lower than readState.Index'  (duration: 198.285µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:16:24.371594Z","caller":"traceutil/trace.go:171","msg":"trace[267979857] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"264.944145ms","start":"2026-03-20T10:16:24.106633Z","end":"2026-03-20T10:16:24.371577Z","steps":["trace[267979857] 'process raft request'  (duration: 264.680359ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:24.3717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.89734ms","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:507"}
{"level":"info","ts":"2026-03-20T10:16:24.371744Z","caller":"traceutil/trace.go:171","msg":"trace[384089136] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1058; }","duration":"263.956132ms","start":"2026-03-20T10:16:24.107776Z","end":"2026-03-20T10:16:24.371732Z","steps":["trace[384089136] 'agreement among raft nodes before linearized reading'  (duration: 263.788068ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:25.504444Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.127745747s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T10:16:25.583336Z","caller":"traceutil/trace.go:171","msg":"trace[1590622129] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"1.206670958s","start":"2026-03-20T10:16:24.376619Z","end":"2026-03-20T10:16:25.58329Z","steps":["trace[1590622129] 'process raft request'  (duration: 1.128201058s)","trace[1590622129] 'compare'  (duration: 77.540929ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:16:25.583439Z","caller":"traceutil/trace.go:171","msg":"trace[745417077] linearizableReadLoop","detail":"{readStateIndex:1102; appliedIndex:1101; }","duration":"429.841039ms","start":"2026-03-20T10:16:25.153536Z","end":"2026-03-20T10:16:25.583377Z","steps":["trace[745417077] 'read index received'  (duration: 351.290777ms)","trace[745417077] 'applied index is now lower than readState.Index'  (duration: 78.536912ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:16:25.583511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:24.376597Z","time spent":"1.206823761s","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1014 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:422 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-20T10:16:25.583996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.427813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-03-20T10:16:25.584192Z","caller":"traceutil/trace.go:171","msg":"trace[2005164573] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1059; }","duration":"430.679798ms","start":"2026-03-20T10:16:25.153486Z","end":"2026-03-20T10:16:25.584166Z","steps":["trace[2005164573] 'agreement among raft nodes before linearized reading'  (duration: 429.969562ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:25.58423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.605905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:16:25.584277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:16:25.153465Z","time spent":"430.798551ms","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-20T10:16:25.584338Z","caller":"traceutil/trace.go:171","msg":"trace[1862677386] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1060; }","duration":"202.79955ms","start":"2026-03-20T10:16:25.381512Z","end":"2026-03-20T10:16:25.584312Z","steps":["trace[1862677386] 'agreement among raft nodes before linearized reading'  (duration: 202.566274ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:25.584772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.959467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"}
{"level":"info","ts":"2026-03-20T10:16:25.584826Z","caller":"traceutil/trace.go:171","msg":"trace[130219787] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1060; }","duration":"107.105861ms","start":"2026-03-20T10:16:25.477703Z","end":"2026-03-20T10:16:25.584809Z","steps":["trace[130219787] 'agreement among raft nodes before linearized reading'  (duration: 106.941667ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:25.584831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.115451ms","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:16:25.584868Z","caller":"traceutil/trace.go:171","msg":"trace[1542215578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1060; }","duration":"175.212212ms","start":"2026-03-20T10:16:25.409644Z","end":"2026-03-20T10:16:25.584857Z","steps":["trace[1542215578] 'agreement among raft nodes before linearized reading'  (duration: 175.068359ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:25.58499Z","caller":"traceutil/trace.go:171","msg":"trace[961223309] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"298.137419ms","start":"2026-03-20T10:16:25.286839Z","end":"2026-03-20T10:16:25.584976Z","steps":["trace[961223309] 'process raft request'  (duration: 297.093085ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:25.716408Z","caller":"traceutil/trace.go:171","msg":"trace[1606074801] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"125.878455ms","start":"2026-03-20T10:16:25.590487Z","end":"2026-03-20T10:16:25.716365Z","steps":["trace[1606074801] 'process raft request'  (duration: 120.617674ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:25.716767Z","caller":"traceutil/trace.go:171","msg":"trace[939333852] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"125.884515ms","start":"2026-03-20T10:16:25.590841Z","end":"2026-03-20T10:16:25.716725Z","steps":["trace[939333852] 'process raft request'  (duration: 125.502666ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:42.63763Z","caller":"traceutil/trace.go:171","msg":"trace[32388886] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"150.254518ms","start":"2026-03-20T10:16:42.48735Z","end":"2026-03-20T10:16:42.637604Z","steps":["trace[32388886] 'process raft request'  (duration: 150.104524ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:44.011809Z","caller":"traceutil/trace.go:171","msg":"trace[284255390] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"111.319529ms","start":"2026-03-20T10:16:43.900466Z","end":"2026-03-20T10:16:44.011786Z","steps":["trace[284255390] 'process raft request'  (duration: 111.274658ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:44.011859Z","caller":"traceutil/trace.go:171","msg":"trace[353012164] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"112.62771ms","start":"2026-03-20T10:16:43.899184Z","end":"2026-03-20T10:16:44.011812Z","steps":["trace[353012164] 'process raft request'  (duration: 112.452195ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:50.159482Z","caller":"traceutil/trace.go:171","msg":"trace[1871078161] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"121.925194ms","start":"2026-03-20T10:16:50.037505Z","end":"2026-03-20T10:16:50.15943Z","steps":["trace[1871078161] 'process raft request'  (duration: 82.000582ms)","trace[1871078161] 'compare'  (duration: 39.588864ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:16:50.188716Z","caller":"traceutil/trace.go:171","msg":"trace[870348225] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"149.552982ms","start":"2026-03-20T10:16:50.039132Z","end":"2026-03-20T10:16:50.188685Z","steps":["trace[870348225] 'process raft request'  (duration: 149.380048ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:20.510836Z","caller":"traceutil/trace.go:171","msg":"trace[1119500630] linearizableReadLoop","detail":"{readStateIndex:1338; appliedIndex:1337; }","duration":"251.291383ms","start":"2026-03-20T10:17:20.259507Z","end":"2026-03-20T10:17:20.510799Z","steps":["trace[1119500630] 'read index received'  (duration: 251.017447ms)","trace[1119500630] 'applied index is now lower than readState.Index'  (duration: 273.006µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:17:20.511078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.759484ms","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:20.51101Z","caller":"traceutil/trace.go:171","msg":"trace[1016430121] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"308.051669ms","start":"2026-03-20T10:17:20.202903Z","end":"2026-03-20T10:17:20.510954Z","steps":["trace[1016430121] 'process raft request'  (duration: 307.69517ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:17:20.511201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.673183ms","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:17:20.511247Z","caller":"traceutil/trace.go:171","msg":"trace[1460414141] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1284; }","duration":"128.991139ms","start":"2026-03-20T10:17:20.382232Z","end":"2026-03-20T10:17:20.511223Z","steps":["trace[1460414141] 'agreement among raft nodes before linearized reading'  (duration: 128.770324ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:20.51127Z","caller":"traceutil/trace.go:171","msg":"trace[1117889149] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1284; }","duration":"251.810296ms","start":"2026-03-20T10:17:20.259444Z","end":"2026-03-20T10:17:20.511254Z","steps":["trace[1117889149] 'agreement among raft nodes before linearized reading'  (duration: 251.56633ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:17:20.511338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:17:20.202865Z","time spent":"308.391517ms","remote":"127.0.0.1:37746","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:1276 > 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:17:21.130302Z","caller":"traceutil/trace.go:171","msg":"trace[192124789] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"112.063207ms","start":"2026-03-20T10:17:21.01821Z","end":"2026-03-20T10:17:21.130274Z","steps":["trace[192124789] 'process raft request'  (duration: 111.875253ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:44.738859Z","caller":"traceutil/trace.go:171","msg":"trace[1032857534] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"105.69379ms","start":"2026-03-20T10:17:44.633135Z","end":"2026-03-20T10:17:44.738829Z","steps":["trace[1032857534] 'process raft request'  (duration: 105.515095ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:45.911035Z","caller":"traceutil/trace.go:171","msg":"trace[1926082726] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"109.942948ms","start":"2026-03-20T10:17:45.801057Z","end":"2026-03-20T10:17:45.911Z","steps":["trace[1926082726] 'process raft request'  (duration: 109.735653ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:46.922757Z","caller":"traceutil/trace.go:171","msg":"trace[1252061495] linearizableReadLoop","detail":"{readStateIndex:1450; appliedIndex:1449; }","duration":"175.375804ms","start":"2026-03-20T10:17:46.747359Z","end":"2026-03-20T10:17:46.922735Z","steps":["trace[1252061495] 'read index received'  (duration: 85.245435ms)","trace[1252061495] 'applied index is now lower than readState.Index'  (duration: 90.129519ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:17:46.922855Z","caller":"traceutil/trace.go:171","msg":"trace[13139933] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"182.576731ms","start":"2026-03-20T10:17:46.74027Z","end":"2026-03-20T10:17:46.922847Z","steps":["trace[13139933] 'process raft request'  (duration: 92.386511ms)","trace[13139933] 'compare'  (duration: 89.779891ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:17:46.923011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.63562ms","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:17:46.923028Z","caller":"traceutil/trace.go:171","msg":"trace[1129386801] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1391; }","duration":"175.709071ms","start":"2026-03-20T10:17:46.747313Z","end":"2026-03-20T10:17:46.923022Z","steps":["trace[1129386801] 'agreement among raft nodes before linearized reading'  (duration: 175.613649ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:56.159038Z","caller":"traceutil/trace.go:171","msg":"trace[2029570310] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"174.172286ms","start":"2026-03-20T10:17:55.984817Z","end":"2026-03-20T10:17:56.15899Z","steps":["trace[2029570310] 'process raft request'  (duration: 126.240795ms)","trace[2029570310] 'compare'  (duration: 47.647514ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:17:58.643805Z","caller":"traceutil/trace.go:171","msg":"trace[949298567] linearizableReadLoop","detail":"{readStateIndex:1501; appliedIndex:1500; }","duration":"177.579637ms","start":"2026-03-20T10:17:58.466179Z","end":"2026-03-20T10:17:58.643759Z","steps":["trace[949298567] 'read index received'  (duration: 118.28501ms)","trace[949298567] 'applied index is now lower than readState.Index'  (duration: 59.293047ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:17:58.644033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.394548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:17:58.64403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.831792ms","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:17:58.644137Z","caller":"traceutil/trace.go:171","msg":"trace[910828779] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1439; }","duration":"178.027747ms","start":"2026-03-20T10:17:58.466083Z","end":"2026-03-20T10:17:58.644111Z","steps":["trace[910828779] 'agreement among raft nodes before linearized reading'  (duration: 177.753631ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:58.644077Z","caller":"traceutil/trace.go:171","msg":"trace[149320177] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1439; }","duration":"114.520331ms","start":"2026-03-20T10:17:58.529545Z","end":"2026-03-20T10:17:58.644065Z","steps":["trace[149320177] 'agreement among raft nodes before linearized reading'  (duration: 114.399148ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:17:59.36678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.390091ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15961492698798667222 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1434 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:17:59.367296Z","caller":"traceutil/trace.go:171","msg":"trace[1394053635] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"267.343014ms","start":"2026-03-20T10:17:59.099914Z","end":"2026-03-20T10:17:59.367257Z","steps":["trace[1394053635] 'process raft request'  (duration: 99.298518ms)","trace[1394053635] 'compare'  (duration: 167.141205ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:17:59.367466Z","caller":"traceutil/trace.go:171","msg":"trace[142569809] transaction","detail":"{read_only:false; response_revision:1444; number_of_response:1; }","duration":"265.655476ms","start":"2026-03-20T10:17:59.101784Z","end":"2026-03-20T10:17:59.367439Z","steps":["trace[142569809] 'process raft request'  (duration: 265.39632ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:17:59.367565Z","caller":"traceutil/trace.go:171","msg":"trace[1015554393] transaction","detail":"{read_only:false; response_revision:1445; number_of_response:1; }","duration":"265.459261ms","start":"2026-03-20T10:17:59.102069Z","end":"2026-03-20T10:17:59.367528Z","steps":["trace[1015554393] 'process raft request'  (duration: 265.259926ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:01.036894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.122677ms","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:18:01.036985Z","caller":"traceutil/trace.go:171","msg":"trace[753855848] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1447; }","duration":"103.270611ms","start":"2026-03-20T10:18:00.933687Z","end":"2026-03-20T10:18:01.036958Z","steps":["trace[753855848] 'range keys from in-memory index tree'  (duration: 102.930703ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:53.770954Z","caller":"traceutil/trace.go:171","msg":"trace[523382313] transaction","detail":"{read_only:false; response_revision:1665; number_of_response:1; }","duration":"102.333879ms","start":"2026-03-20T10:18:53.668595Z","end":"2026-03-20T10:18:53.770929Z","steps":["trace[523382313] 'process raft request'  (duration: 102.218886ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:53.771198Z","caller":"traceutil/trace.go:171","msg":"trace[2004368670] transaction","detail":"{read_only:false; response_revision:1666; number_of_response:1; }","duration":"100.956047ms","start":"2026-03-20T10:18:53.670218Z","end":"2026-03-20T10:18:53.771174Z","steps":["trace[2004368670] 'process raft request'  (duration: 100.67811ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:18:59.931395Z","caller":"traceutil/trace.go:171","msg":"trace[456252757] linearizableReadLoop","detail":"{readStateIndex:1763; appliedIndex:1762; }","duration":"132.692254ms","start":"2026-03-20T10:18:59.798677Z","end":"2026-03-20T10:18:59.931369Z","steps":["trace[456252757] 'read index received'  (duration: 132.557211ms)","trace[456252757] 'applied index is now lower than readState.Index'  (duration: 134.073µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:18:59.931524Z","caller":"traceutil/trace.go:171","msg":"trace[358318125] transaction","detail":"{read_only:false; response_revision:1689; number_of_response:1; }","duration":"135.631552ms","start":"2026-03-20T10:18:59.79588Z","end":"2026-03-20T10:18:59.931512Z","steps":["trace[358318125] 'process raft request'  (duration: 135.343286ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:59.931875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.147745ms","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:59.93198Z","caller":"traceutil/trace.go:171","msg":"trace[71944029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1689; }","duration":"133.286408ms","start":"2026-03-20T10:18:59.798673Z","end":"2026-03-20T10:18:59.931959Z","steps":["trace[71944029] 'agreement among raft nodes before linearized reading'  (duration: 133.029762ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:18:59.932177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.076584ms","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:59.932219Z","caller":"traceutil/trace.go:171","msg":"trace[901085586] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1689; }","duration":"133.147095ms","start":"2026-03-20T10:18:59.799059Z","end":"2026-03-20T10:18:59.932206Z","steps":["trace[901085586] 'agreement among raft nodes before linearized reading'  (duration: 132.568641ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:19:00.269209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.522175ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15961492698798667863 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1681 > 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:19:00.269396Z","caller":"traceutil/trace.go:171","msg":"trace[1659754157] transaction","detail":"{read_only:false; response_revision:1692; number_of_response:1; }","duration":"331.841543ms","start":"2026-03-20T10:18:59.93754Z","end":"2026-03-20T10:19:00.269381Z","steps":["trace[1659754157] 'process raft request'  (duration: 331.813463ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:19:00.269403Z","caller":"traceutil/trace.go:171","msg":"trace[1063549976] transaction","detail":"{read_only:false; response_revision:1690; number_of_response:1; }","duration":"333.069112ms","start":"2026-03-20T10:18:59.936298Z","end":"2026-03-20T10:19:00.269367Z","steps":["trace[1063549976] 'process raft request'  (duration: 140.313281ms)","trace[1063549976] 'compare'  (duration: 192.403753ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:19:00.269547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:59.936276Z","time spent":"333.197376ms","remote":"127.0.0.1:37746","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:1681 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-20T10:19:00.269441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:59.937525Z","time spent":"331.895855ms","remote":"127.0.0.1:37746","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:1682 > 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:19:00.269643Z","caller":"traceutil/trace.go:171","msg":"trace[393337587] transaction","detail":"{read_only:false; response_revision:1691; number_of_response:1; }","duration":"333.197485ms","start":"2026-03-20T10:18:59.93642Z","end":"2026-03-20T10:19:00.269618Z","steps":["trace[393337587] 'process raft request'  (duration: 332.872317ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:19:00.270422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:18:59.936393Z","time spent":"333.301898ms","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1683 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:451 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >"}
{"level":"info","ts":"2026-03-20T10:19:30.651808Z","caller":"traceutil/trace.go:171","msg":"trace[1412400731] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"147.339415ms","start":"2026-03-20T10:19:30.504438Z","end":"2026-03-20T10:19:30.651778Z","steps":["trace[1412400731] 'process raft request'  (duration: 100.933376ms)","trace[1412400731] 'compare'  (duration: 46.299636ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:19:30.715694Z","caller":"traceutil/trace.go:171","msg":"trace[1487535780] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"210.855841ms","start":"2026-03-20T10:19:30.5048Z","end":"2026-03-20T10:19:30.715656Z","steps":["trace[1487535780] 'process raft request'  (duration: 210.674956ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:19:33.559727Z","caller":"traceutil/trace.go:171","msg":"trace[2108858515] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"261.407915ms","start":"2026-03-20T10:19:33.298233Z","end":"2026-03-20T10:19:33.559641Z","steps":["trace[2108858515] 'process raft request'  (duration: 261.242741ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:19:36.575106Z","caller":"traceutil/trace.go:171","msg":"trace[2056482565] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1941; }","duration":"221.759434ms","start":"2026-03-20T10:19:36.353286Z","end":"2026-03-20T10:19:36.575045Z","steps":["trace[2056482565] 'read index received'  (duration: 181.240632ms)","trace[2056482565] 'applied index is now lower than readState.Index'  (duration: 40.516902ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:19:36.575506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.188474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"}
{"level":"warn","ts":"2026-03-20T10:19:36.575581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.541715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:19:36.575608Z","caller":"traceutil/trace.go:171","msg":"trace[909745805] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1860; }","duration":"222.345047ms","start":"2026-03-20T10:19:36.353236Z","end":"2026-03-20T10:19:36.575581Z","steps":["trace[909745805] 'agreement among raft nodes before linearized reading'  (duration: 222.104632ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:19:36.575635Z","caller":"traceutil/trace.go:171","msg":"trace[2045947088] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1860; }","duration":"192.618387ms","start":"2026-03-20T10:19:36.382999Z","end":"2026-03-20T10:19:36.575617Z","steps":["trace[2045947088] 'agreement among raft nodes before linearized reading'  (duration: 192.522805ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:19:36.575581Z","caller":"traceutil/trace.go:171","msg":"trace[1945694882] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"316.889255ms","start":"2026-03-20T10:19:36.258645Z","end":"2026-03-20T10:19:36.575534Z","steps":["trace[1945694882] 'process raft request'  (duration: 275.967574ms)","trace[1945694882] 'compare'  (duration: 40.180334ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:19:36.575962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:19:36.258616Z","time spent":"317.226033ms","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1838 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:422 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-20T10:19:42.954856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.681425ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15961492698798668383 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:1885 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:451 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:19:42.955087Z","caller":"traceutil/trace.go:171","msg":"trace[63234282] linearizableReadLoop","detail":"{readStateIndex:1978; appliedIndex:1977; }","duration":"148.073551ms","start":"2026-03-20T10:19:42.806912Z","end":"2026-03-20T10:19:42.954986Z","steps":["trace[63234282] 'read index received'  (duration: 23.715981ms)","trace[63234282] 'applied index is now lower than readState.Index'  (duration: 124.35544ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:19:42.955234Z","caller":"traceutil/trace.go:171","msg":"trace[1409727888] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"168.059615ms","start":"2026-03-20T10:19:42.786976Z","end":"2026-03-20T10:19:42.955036Z","steps":["trace[1409727888] 'process raft request'  (duration: 43.623633ms)","trace[1409727888] 'compare'  (duration: 123.356457ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:19:42.955367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.418259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-03-20T10:19:42.955477Z","caller":"traceutil/trace.go:171","msg":"trace[1627322598] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1895; }","duration":"148.562273ms","start":"2026-03-20T10:19:42.806888Z","end":"2026-03-20T10:19:42.95545Z","steps":["trace[1627322598] 'agreement among raft nodes before linearized reading'  (duration: 148.237345ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:19:43.884449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.587605ms","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:19:43.884521Z","caller":"traceutil/trace.go:171","msg":"trace[1078170799] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1896; }","duration":"281.694627ms","start":"2026-03-20T10:19:43.60281Z","end":"2026-03-20T10:19:43.884504Z","steps":["trace[1078170799] 'range keys from in-memory index tree'  (duration: 281.457192ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:19:43.884449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.584841ms","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:19:43.884667Z","caller":"traceutil/trace.go:171","msg":"trace[248370276] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1896; }","duration":"786.816047ms","start":"2026-03-20T10:19:43.097837Z","end":"2026-03-20T10:19:43.884653Z","steps":["trace[248370276] 'range keys from in-memory index tree'  (duration: 786.574871ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:19:43.884954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.266676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:19:43.884992Z","caller":"traceutil/trace.go:171","msg":"trace[1747626794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1896; }","duration":"503.353798ms","start":"2026-03-20T10:19:43.381626Z","end":"2026-03-20T10:19:43.88498Z","steps":["trace[1747626794] 'range keys from in-memory index tree'  (duration: 502.498849ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:19:43.885044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:19:43.381597Z","time spent":"503.439131ms","remote":"127.0.0.1:37508","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:19:44.230104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.527935ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15961492698798668390 > lease_revoke:<id:5d829d0abce2b9b2>","response":"size:28"}
{"level":"info","ts":"2026-03-20T10:19:44.230508Z","caller":"traceutil/trace.go:171","msg":"trace[2022202500] linearizableReadLoop","detail":"{readStateIndex:1980; appliedIndex:1979; }","duration":"393.016514ms","start":"2026-03-20T10:19:43.837462Z","end":"2026-03-20T10:19:44.230478Z","steps":["trace[2022202500] 'read index received'  (duration: 92.234973ms)","trace[2022202500] 'applied index is now lower than readState.Index'  (duration: 300.779081ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:19:44.230571Z","caller":"traceutil/trace.go:171","msg":"trace[321994496] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"341.803774ms","start":"2026-03-20T10:19:43.888745Z","end":"2026-03-20T10:19:44.230548Z","steps":["trace[321994496] 'process raft request'  (duration: 341.490237ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:19:44.23069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:19:43.888729Z","time spent":"341.889737ms","remote":"127.0.0.1:37746","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:1887 > 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:19:44.230799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.318722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-03-20T10:19:44.23084Z","caller":"traceutil/trace.go:171","msg":"trace[1143943281] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1897; }","duration":"393.425775ms","start":"2026-03-20T10:19:43.837404Z","end":"2026-03-20T10:19:44.23083Z","steps":["trace[1143943281] 'agreement among raft nodes before linearized reading'  (duration: 393.21853ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:19:44.230901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:19:43.837388Z","time spent":"393.504166ms","remote":"127.0.0.1:37746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-20T10:19:44.231052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.119942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:19:44.231096Z","caller":"traceutil/trace.go:171","msg":"trace[465447143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1897; }","duration":"345.197784ms","start":"2026-03-20T10:19:43.885888Z","end":"2026-03-20T10:19:44.231085Z","steps":["trace[465447143] 'agreement among raft nodes before linearized reading'  (duration: 345.118042ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:19:44.231129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:19:43.885866Z","time spent":"345.255884ms","remote":"127.0.0.1:37496","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:19:44.231186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.709642ms","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":"info","ts":"2026-03-20T10:19:44.231262Z","caller":"traceutil/trace.go:171","msg":"trace[1398606119] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1897; }","duration":"344.792864ms","start":"2026-03-20T10:19:43.88645Z","end":"2026-03-20T10:19:44.231243Z","steps":["trace[1398606119] 'agreement among raft nodes before linearized reading'  (duration: 344.574979ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:19:44.231303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:19:43.886423Z","time spent":"344.871165ms","remote":"127.0.0.1:37746","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":"info","ts":"2026-03-20T10:19:44.362308Z","caller":"traceutil/trace.go:171","msg":"trace[1008291611] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"126.535662ms","start":"2026-03-20T10:19:44.235733Z","end":"2026-03-20T10:19:44.362268Z","steps":["trace[1008291611] 'process raft request'  (duration: 104.183852ms)","trace[1008291611] 'compare'  (duration: 22.083883ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:19:44.362366Z","caller":"traceutil/trace.go:171","msg":"trace[2083138028] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"126.295246ms","start":"2026-03-20T10:19:44.236044Z","end":"2026-03-20T10:19:44.362339Z","steps":["trace[2083138028] 'process raft request'  (duration: 126.126842ms)"],"step_count":1}