{"level":"warn","ts":"2026-03-13T09:48:20.854699Z","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-13T09:48:20.854835Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.150: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.150:2380","--initial-cluster=instance=https://199.19.213.150:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.150:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.150: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-13T09:48:20.854961Z","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-13T09:48:20.854976Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.150:2380"]}
{"level":"info","ts":"2026-03-13T09:48:20.855008Z","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-13T09:48:20.855877Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.150:2379"]}
{"level":"info","ts":"2026-03-13T09:48:20.856Z","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.150:2380"],"listen-peer-urls":["https://199.19.213.150:2380"],"advertise-client-urls":["https://199.19.213.150:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.150:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.150: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-13T09:48:20.869455Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"13.134382ms"}
{"level":"info","ts":"2026-03-13T09:48:20.891419Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dbd0ffa4f8c99812","cluster-id":"98aad832cd49bc30"}
{"level":"info","ts":"2026-03-13T09:48:20.891547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-13T09:48:20.891576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became follower at term 0"}
{"level":"info","ts":"2026-03-13T09:48:20.891592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dbd0ffa4f8c99812 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-13T09:48:20.891665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became follower at term 1"}
{"level":"info","ts":"2026-03-13T09:48:20.891739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 switched to configuration voters=(15839440973475715090)"}
{"level":"warn","ts":"2026-03-13T09:48:20.904124Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-13T09:48:20.90614Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-13T09:48:20.907813Z","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-13T09:48:20.91185Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dbd0ffa4f8c99812","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-13T09:48:20.911995Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dbd0ffa4f8c99812","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-13T09:48:20.912242Z","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-13T09:48:20.91233Z","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-13T09:48:20.91234Z","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-13T09:48:20.914085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 switched to configuration voters=(15839440973475715090)"}
{"level":"info","ts":"2026-03-13T09:48:20.914462Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"98aad832cd49bc30","local-member-id":"dbd0ffa4f8c99812","added-peer-id":"dbd0ffa4f8c99812","added-peer-peer-urls":["https://199.19.213.150:2380"]}
{"level":"info","ts":"2026-03-13T09:48:20.922257Z","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-13T09:48:20.922512Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dbd0ffa4f8c99812","initial-advertise-peer-urls":["https://199.19.213.150:2380"],"listen-peer-urls":["https://199.19.213.150:2380"],"advertise-client-urls":["https://199.19.213.150:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.150:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-13T09:48:20.922552Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-13T09:48:20.92266Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.150:2380"}
{"level":"info","ts":"2026-03-13T09:48:20.922768Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.150:2380"}
{"level":"info","ts":"2026-03-13T09:48:21.092424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-13T09:48:21.092518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-13T09:48:21.09259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 received MsgPreVoteResp from dbd0ffa4f8c99812 at term 1"}
{"level":"info","ts":"2026-03-13T09:48:21.092621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became candidate at term 2"}
{"level":"info","ts":"2026-03-13T09:48:21.092638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 received MsgVoteResp from dbd0ffa4f8c99812 at term 2"}
{"level":"info","ts":"2026-03-13T09:48:21.092665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became leader at term 2"}
{"level":"info","ts":"2026-03-13T09:48:21.092682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dbd0ffa4f8c99812 elected leader dbd0ffa4f8c99812 at term 2"}
{"level":"info","ts":"2026-03-13T09:48:21.097784Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-13T09:48:21.099424Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-13T09:48:21.09943Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dbd0ffa4f8c99812","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.150:2379]}","request-path":"/0/members/dbd0ffa4f8c99812/attributes","cluster-id":"98aad832cd49bc30","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-13T09:48:21.099553Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-13T09:48:21.099939Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-13T09:48:21.100082Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-13T09:48:21.102136Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-13T09:48:21.102698Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"98aad832cd49bc30","local-member-id":"dbd0ffa4f8c99812","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-13T09:48:21.102791Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-13T09:48:21.103391Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-13T09:48:21.111885Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.150:2379"}
{"level":"warn","ts":"2026-03-13T09:48:42.70208Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10957993357566156754,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-13T09:48:42.803047Z","caller":"traceutil/trace.go:171","msg":"trace[373173082] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"736.650126ms","start":"2026-03-13T09:48:42.066381Z","end":"2026-03-13T09:48:42.803032Z","steps":["trace[373173082] 'process raft request'  (duration: 736.477212ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:48:42.803134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.709049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-13T09:48:42.803012Z","caller":"traceutil/trace.go:171","msg":"trace[2109827602] linearizableReadLoop","detail":"{readStateIndex:468; appliedIndex:467; }","duration":"601.579426ms","start":"2026-03-13T09:48:42.201406Z","end":"2026-03-13T09:48:42.802986Z","steps":["trace[2109827602] 'read index received'  (duration: 601.440932ms)","trace[2109827602] 'applied index is now lower than readState.Index'  (duration: 137.544µs)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:48:42.803205Z","caller":"traceutil/trace.go:171","msg":"trace[1442206083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:452; }","duration":"601.831912ms","start":"2026-03-13T09:48:42.201362Z","end":"2026-03-13T09:48:42.803194Z","steps":["trace[1442206083] 'agreement among raft nodes before linearized reading'  (duration: 601.72924ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:48:42.803236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:48:42.201342Z","time spent":"601.886934ms","remote":"127.0.0.1:38042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-13T09:48:42.803452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:48:42.066349Z","time spent":"736.742429ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:448 > 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-13T09:48:47.885903Z","caller":"traceutil/trace.go:171","msg":"trace[1687556138] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"269.723581ms","start":"2026-03-13T09:48:47.616155Z","end":"2026-03-13T09:48:47.885879Z","steps":["trace[1687556138] 'process raft request'  (duration: 269.581967ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:48:51.625433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.02020229s","expected-duration":"100ms","prefix":"","request":"header:<ID:10957993357566156832 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/daemonsets/kube-system/cilium\" mod_revision:0 > success:<request_put:<key:\"/registry/daemonsets/kube-system/cilium\" value_size:14166 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-13T09:48:51.625561Z","caller":"traceutil/trace.go:171","msg":"trace[1712715755] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:498; }","duration":"769.645517ms","start":"2026-03-13T09:48:50.855897Z","end":"2026-03-13T09:48:51.625543Z","steps":["trace[1712715755] 'read index received'  (duration: 79.172µs)","trace[1712715755] 'applied index is now lower than readState.Index'  (duration: 769.565374ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:48:51.6256Z","caller":"traceutil/trace.go:171","msg":"trace[1176665587] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"1.200641705s","start":"2026-03-13T09:48:50.424916Z","end":"2026-03-13T09:48:51.625557Z","steps":["trace[1176665587] 'process raft request'  (duration: 180.049956ms)","trace[1176665587] 'compare'  (duration: 1.019995995s)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T09:48:51.625723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.83183ms","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-13T09:48:51.625749Z","caller":"traceutil/trace.go:171","msg":"trace[968660572] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:481; }","duration":"769.919222ms","start":"2026-03-13T09:48:50.855822Z","end":"2026-03-13T09:48:51.625741Z","steps":["trace[968660572] 'agreement among raft nodes before linearized reading'  (duration: 769.81475ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:48:51.62576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:48:50.424896Z","time spent":"1.200781519s","remote":"127.0.0.1:38536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14213,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/daemonsets/kube-system/cilium\" mod_revision:0 > success:<request_put:<key:\"/registry/daemonsets/kube-system/cilium\" value_size:14166 >> failure:<>"}
{"level":"warn","ts":"2026-03-13T09:48:51.625782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:48:50.855794Z","time spent":"769.980594ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-13T09:48:51.62579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.908576ms","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-13T09:48:51.625829Z","caller":"traceutil/trace.go:171","msg":"trace[1814204900] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:481; }","duration":"748.992728ms","start":"2026-03-13T09:48:50.876824Z","end":"2026-03-13T09:48:51.625817Z","steps":["trace[1814204900] 'agreement among raft nodes before linearized reading'  (duration: 748.921986ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:48:51.625852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:48:50.87679Z","time spent":"749.05723ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-13T09:48:51.625934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.563607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-13T09:48:51.625951Z","caller":"traceutil/trace.go:171","msg":"trace[235201813] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:481; }","duration":"434.631109ms","start":"2026-03-13T09:48:51.191315Z","end":"2026-03-13T09:48:51.625946Z","steps":["trace[235201813] 'agreement among raft nodes before linearized reading'  (duration: 434.595207ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:48:51.625971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:48:51.191287Z","time spent":"434.67936ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-13T09:48:54.136142Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10957993357566156875,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-13T09:48:54.179359Z","caller":"traceutil/trace.go:171","msg":"trace[1855083504] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:526; }","duration":"543.328022ms","start":"2026-03-13T09:48:53.635907Z","end":"2026-03-13T09:48:54.179235Z","steps":["trace[1855083504] 'read index received'  (duration: 543.094416ms)","trace[1855083504] 'applied index is now lower than readState.Index'  (duration: 232.226µs)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:48:54.179722Z","caller":"traceutil/trace.go:171","msg":"trace[551641952] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"693.215887ms","start":"2026-03-13T09:48:53.486486Z","end":"2026-03-13T09:48:54.179702Z","steps":["trace[551641952] 'process raft request'  (duration: 692.587913ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:48:54.179856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:48:53.486465Z","time spent":"693.304559ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:455 > 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-13T09:48:54.180104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.189071ms","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-13T09:48:54.180159Z","caller":"traceutil/trace.go:171","msg":"trace[1868861320] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:509; }","duration":"544.271523ms","start":"2026-03-13T09:48:53.635874Z","end":"2026-03-13T09:48:54.180146Z","steps":["trace[1868861320] 'agreement among raft nodes before linearized reading'  (duration: 544.176031ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:48:54.180207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:48:53.63586Z","time spent":"544.336624ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-13T09:48:54.180417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.68965ms","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-13T09:48:54.180468Z","caller":"traceutil/trace.go:171","msg":"trace[1376760460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:509; }","duration":"543.752861ms","start":"2026-03-13T09:48:53.636703Z","end":"2026-03-13T09:48:54.180455Z","steps":["trace[1376760460] 'agreement among raft nodes before linearized reading'  (duration: 543.668289ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:48:54.180508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:48:53.636697Z","time spent":"543.797352ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-13T09:48:54.18076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.24288ms","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-13T09:48:54.180811Z","caller":"traceutil/trace.go:171","msg":"trace[848066728] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:509; }","duration":"262.321193ms","start":"2026-03-13T09:48:53.918477Z","end":"2026-03-13T09:48:54.180799Z","steps":["trace[848066728] 'agreement among raft nodes before linearized reading'  (duration: 262.24247ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:48:54.181122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.983537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-13T09:48:54.181221Z","caller":"traceutil/trace.go:171","msg":"trace[1367600921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:509; }","duration":"544.10256ms","start":"2026-03-13T09:48:53.637098Z","end":"2026-03-13T09:48:54.181201Z","steps":["trace[1367600921] 'agreement among raft nodes before linearized reading'  (duration: 543.921156ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:48:54.181275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:48:53.637094Z","time spent":"544.170381ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-13T09:49:00.66458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.551158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-13T09:49:00.664639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.170252ms","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-13T09:49:00.664678Z","caller":"traceutil/trace.go:171","msg":"trace[1459848175] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:551; }","duration":"347.702072ms","start":"2026-03-13T09:49:00.316947Z","end":"2026-03-13T09:49:00.664649Z","steps":["trace[1459848175] 'range keys from in-memory index tree'  (duration: 347.289643ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:49:00.664727Z","caller":"traceutil/trace.go:171","msg":"trace[2039206540] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:551; }","duration":"342.288965ms","start":"2026-03-13T09:49:00.322413Z","end":"2026-03-13T09:49:00.664702Z","steps":["trace[2039206540] 'range keys from in-memory index tree'  (duration: 342.021489ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:00.664735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:00.316927Z","time spent":"347.797313ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-13T09:49:00.664768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:00.322399Z","time spent":"342.359046ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-13T09:49:01.286563Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10957993357566156965,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-13T09:49:01.365018Z","caller":"traceutil/trace.go:171","msg":"trace[561377826] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"696.316466ms","start":"2026-03-13T09:49:00.668683Z","end":"2026-03-13T09:49:01.364999Z","steps":["trace[561377826] 'process raft request'  (duration: 696.168273ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:01.36515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:00.668661Z","time spent":"696.419697ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:545 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-13T09:49:01.465955Z","caller":"traceutil/trace.go:171","msg":"trace[108880754] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:571; }","duration":"680.429103ms","start":"2026-03-13T09:49:00.785497Z","end":"2026-03-13T09:49:01.465926Z","steps":["trace[108880754] 'read index received'  (duration: 579.437743ms)","trace[108880754] 'applied index is now lower than readState.Index'  (duration: 100.99027ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:49:01.466124Z","caller":"traceutil/trace.go:171","msg":"trace[645106324] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"797.329555ms","start":"2026-03-13T09:49:00.668778Z","end":"2026-03-13T09:49:01.466108Z","steps":["trace[645106324] 'process raft request'  (duration: 715.996356ms)","trace[645106324] 'compare'  (duration: 81.020972ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T09:49:01.466347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:00.668752Z","time spent":"797.414067ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:546 > 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-13T09:49:01.466352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.024681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-13T09:49:01.466394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.882502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-v2dm5\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-03-13T09:49:01.466433Z","caller":"traceutil/trace.go:171","msg":"trace[1624681797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"304.149334ms","start":"2026-03-13T09:49:01.162265Z","end":"2026-03-13T09:49:01.466414Z","steps":["trace[1624681797] 'agreement among raft nodes before linearized reading'  (duration: 304.016931ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:49:01.466458Z","caller":"traceutil/trace.go:171","msg":"trace[1247698775] range","detail":"{range_begin:/registry/pods/kube-system/cilium-v2dm5; range_end:; response_count:1; response_revision:553; }","duration":"680.999365ms","start":"2026-03-13T09:49:00.785445Z","end":"2026-03-13T09:49:01.466444Z","steps":["trace[1247698775] 'agreement among raft nodes before linearized reading'  (duration: 680.861632ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:01.466472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:01.162238Z","time spent":"304.225896ms","remote":"127.0.0.1:38042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-13T09:49:01.466486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:00.785425Z","time spent":"681.055296ms","remote":"127.0.0.1:38218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-v2dm5\" "}
{"level":"warn","ts":"2026-03-13T09:49:02.517699Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.0373472s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-13T09:49:02.518009Z","caller":"traceutil/trace.go:171","msg":"trace[1442535290] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:573; }","duration":"282.285105ms","start":"2026-03-13T09:49:02.235708Z","end":"2026-03-13T09:49:02.517993Z","steps":["trace[1442535290] 'read index received'  (duration: 282.123302ms)","trace[1442535290] 'applied index is now lower than readState.Index'  (duration: 160.563µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T09:49:02.518319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.706479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-13T09:49:02.51836Z","caller":"traceutil/trace.go:171","msg":"trace[460786334] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"278.785081ms","start":"2026-03-13T09:49:02.239565Z","end":"2026-03-13T09:49:02.51835Z","steps":["trace[460786334] 'agreement among raft nodes before linearized reading'  (duration: 278.648408ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:02.51847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.702283ms","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-13T09:49:02.518612Z","caller":"traceutil/trace.go:171","msg":"trace[2030412686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:554; }","duration":"282.909108ms","start":"2026-03-13T09:49:02.235633Z","end":"2026-03-13T09:49:02.518542Z","steps":["trace[2030412686] 'agreement among raft nodes before linearized reading'  (duration: 282.592231ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:49:02.518834Z","caller":"traceutil/trace.go:171","msg":"trace[2082305698] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"1.038649217s","start":"2026-03-13T09:49:01.480158Z","end":"2026-03-13T09:49:02.518808Z","steps":["trace[2082305698] 'process raft request'  (duration: 1.037720128s)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:02.51895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:01.480124Z","time spent":"1.038765219s","remote":"127.0.0.1:38218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-v2dm5\" mod_revision:502 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-v2dm5\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-v2dm5\" > >"}
{"level":"warn","ts":"2026-03-13T09:49:03.627044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.255989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-13T09:49:03.627188Z","caller":"traceutil/trace.go:171","msg":"trace[505676670] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"467.454705ms","start":"2026-03-13T09:49:03.159711Z","end":"2026-03-13T09:49:03.627165Z","steps":["trace[505676670] 'range keys from in-memory index tree'  (duration: 467.117677ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:03.627257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:03.159691Z","time spent":"467.550806ms","remote":"127.0.0.1:38042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-13T09:49:03.627355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.372326ms","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-13T09:49:03.627381Z","caller":"traceutil/trace.go:171","msg":"trace[1777880872] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:556; }","duration":"155.460288ms","start":"2026-03-13T09:49:03.471914Z","end":"2026-03-13T09:49:03.627375Z","steps":["trace[1777880872] 'range keys from in-memory index tree'  (duration: 155.276674ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:03.627258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.413912ms","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-13T09:49:03.627465Z","caller":"traceutil/trace.go:171","msg":"trace[1798070589] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:556; }","duration":"258.649507ms","start":"2026-03-13T09:49:03.368792Z","end":"2026-03-13T09:49:03.627442Z","steps":["trace[1798070589] 'range keys from in-memory index tree'  (duration: 258.233059ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:49:04.212323Z","caller":"traceutil/trace.go:171","msg":"trace[1903248961] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"581.471042ms","start":"2026-03-13T09:49:03.630822Z","end":"2026-03-13T09:49:04.212293Z","steps":["trace[1903248961] 'process raft request'  (duration: 581.288178ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:04.212529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:03.63081Z","time spent":"581.595714ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:553 > 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-13T09:49:05.357432Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.145194829s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-13T09:49:05.391482Z","caller":"traceutil/trace.go:171","msg":"trace[118590912] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:576; }","duration":"1.229567342s","start":"2026-03-13T09:49:04.16182Z","end":"2026-03-13T09:49:05.391388Z","steps":["trace[118590912] 'read index received'  (duration: 50.321909ms)","trace[118590912] 'applied index is now lower than readState.Index'  (duration: 1.179197652s)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:49:05.391839Z","caller":"traceutil/trace.go:171","msg":"trace[860789968] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"1.760314296s","start":"2026-03-13T09:49:03.631494Z","end":"2026-03-13T09:49:05.391808Z","steps":["trace[860789968] 'process raft request'  (duration: 1.726174821s)","trace[860789968] 'compare'  (duration: 31.639054ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T09:49:05.392044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:03.631477Z","time spent":"1.76048752s","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:552 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-13T09:49:05.393312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.231298468s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-13T09:49:05.393369Z","caller":"traceutil/trace.go:171","msg":"trace[1891283206] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"1.231567222s","start":"2026-03-13T09:49:04.161781Z","end":"2026-03-13T09:49:05.393348Z","steps":["trace[1891283206] 'agreement among raft nodes before linearized reading'  (duration: 1.229971639s)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:05.393401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:04.161763Z","time spent":"1.231629984s","remote":"127.0.0.1:38042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-13T09:49:05.497169Z","caller":"traceutil/trace.go:171","msg":"trace[1326983147] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:578; }","duration":"105.565492ms","start":"2026-03-13T09:49:05.391572Z","end":"2026-03-13T09:49:05.497138Z","steps":["trace[1326983147] 'read index received'  (duration: 103.321885ms)","trace[1326983147] 'applied index is now lower than readState.Index'  (duration: 2.242387ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:49:05.497266Z","caller":"traceutil/trace.go:171","msg":"trace[34421651] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"1.092039687s","start":"2026-03-13T09:49:04.40519Z","end":"2026-03-13T09:49:05.49723Z","steps":["trace[34421651] 'process raft request'  (duration: 1.089776411s)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:05.497341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.856535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-13T09:49:05.497298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"851.689368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.150\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-13T09:49:05.497386Z","caller":"traceutil/trace.go:171","msg":"trace[1224262559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:559; }","duration":"926.944406ms","start":"2026-03-13T09:49:04.570431Z","end":"2026-03-13T09:49:05.497375Z","steps":["trace[1224262559] 'agreement among raft nodes before linearized reading'  (duration: 926.758483ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:05.497403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:04.405165Z","time spent":"1.09216979s","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:509 > 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-13T09:49:05.497411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:04.570409Z","time spent":"926.996758ms","remote":"127.0.0.1:38326","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-13T09:49:05.497403Z","caller":"traceutil/trace.go:171","msg":"trace[1194089579] range","detail":"{range_begin:/registry/masterleases/199.19.213.150; range_end:; response_count:1; response_revision:559; }","duration":"851.849462ms","start":"2026-03-13T09:49:04.645536Z","end":"2026-03-13T09:49:05.497385Z","steps":["trace[1194089579] 'agreement among raft nodes before linearized reading'  (duration: 851.635047ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:05.49745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:04.645495Z","time spent":"851.943474ms","remote":"127.0.0.1:38058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.150\" "}
{"level":"warn","ts":"2026-03-13T09:49:05.498166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.727332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-13T09:49:05.498219Z","caller":"traceutil/trace.go:171","msg":"trace[1104071379] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:559; }","duration":"103.58439ms","start":"2026-03-13T09:49:05.394619Z","end":"2026-03-13T09:49:05.498203Z","steps":["trace[1104071379] 'agreement among raft nodes before linearized reading'  (duration: 102.715483ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:05.498926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.703606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-13T09:49:05.49906Z","caller":"traceutil/trace.go:171","msg":"trace[2052977743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:559; }","duration":"945.184797ms","start":"2026-03-13T09:49:04.553844Z","end":"2026-03-13T09:49:05.499029Z","steps":["trace[2052977743] 'agreement among raft nodes before linearized reading'  (duration: 943.473771ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:05.49912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:04.55382Z","time spent":"945.285209ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-13T09:49:05.941228Z","caller":"traceutil/trace.go:171","msg":"trace[1981058450] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"135.808526ms","start":"2026-03-13T09:49:05.805398Z","end":"2026-03-13T09:49:05.941206Z","steps":["trace[1981058450] 'process raft request'  (duration: 135.658113ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:49:05.943781Z","caller":"traceutil/trace.go:171","msg":"trace[1168280345] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"124.658696ms","start":"2026-03-13T09:49:05.819083Z","end":"2026-03-13T09:49:05.943742Z","steps":["trace[1168280345] 'process raft request'  (duration: 124.496241ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:07.515158Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10957993357566157033,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-13T09:49:07.562372Z","caller":"traceutil/trace.go:171","msg":"trace[1441417894] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"577.071305ms","start":"2026-03-13T09:49:06.98527Z","end":"2026-03-13T09:49:07.562341Z","steps":["trace[1441417894] 'process raft request'  (duration: 576.866031ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:07.562569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:06.985245Z","time spent":"577.218378ms","remote":"127.0.0.1:38084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4068,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" mod_revision:586 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" value_size:3977 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" > >"}
{"level":"info","ts":"2026-03-13T09:49:07.571508Z","caller":"traceutil/trace.go:171","msg":"trace[66792006] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:609; }","duration":"557.054076ms","start":"2026-03-13T09:49:07.014428Z","end":"2026-03-13T09:49:07.571482Z","steps":["trace[66792006] 'read index received'  (duration: 547.758786ms)","trace[66792006] 'applied index is now lower than readState.Index'  (duration: 9.29432ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:49:07.571556Z","caller":"traceutil/trace.go:171","msg":"trace[1922759082] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"254.997619ms","start":"2026-03-13T09:49:07.31652Z","end":"2026-03-13T09:49:07.571518Z","steps":["trace[1922759082] 'process raft request'  (duration: 254.788354ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:07.571776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.361147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-13T09:49:07.571842Z","caller":"traceutil/trace.go:171","msg":"trace[445687066] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:590; }","duration":"443.49545ms","start":"2026-03-13T09:49:07.128332Z","end":"2026-03-13T09:49:07.571828Z","steps":["trace[445687066] 'agreement among raft nodes before linearized reading'  (duration: 443.365087ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:07.571842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.107258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-13T09:49:07.571871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:07.128304Z","time spent":"443.56214ms","remote":"127.0.0.1:38084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "}
{"level":"info","ts":"2026-03-13T09:49:07.571891Z","caller":"traceutil/trace.go:171","msg":"trace[1766051259] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:590; }","duration":"243.231311ms","start":"2026-03-13T09:49:07.328646Z","end":"2026-03-13T09:49:07.571877Z","steps":["trace[1766051259] 'agreement among raft nodes before linearized reading'  (duration: 243.126458ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:07.57193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.741609ms","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-13T09:49:07.571962Z","caller":"traceutil/trace.go:171","msg":"trace[1947270013] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:590; }","duration":"171.829111ms","start":"2026-03-13T09:49:07.400122Z","end":"2026-03-13T09:49:07.571951Z","steps":["trace[1947270013] 'agreement among raft nodes before linearized reading'  (duration: 171.733429ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:07.571947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.232904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-13T09:49:07.571996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.564746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-557vx\" ","response":"range_response_count:1 size:4888"}
{"level":"info","ts":"2026-03-13T09:49:07.572048Z","caller":"traceutil/trace.go:171","msg":"trace[1967388050] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-557vx; range_end:; response_count:1; response_revision:590; }","duration":"557.617607ms","start":"2026-03-13T09:49:07.014421Z","end":"2026-03-13T09:49:07.572039Z","steps":["trace[1967388050] 'agreement among raft nodes before linearized reading'  (duration: 557.507125ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:07.572072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:07.014362Z","time spent":"557.702388ms","remote":"127.0.0.1:38218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4912,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-557vx\" "}
{"level":"info","ts":"2026-03-13T09:49:07.572053Z","caller":"traceutil/trace.go:171","msg":"trace[517949764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"410.400457ms","start":"2026-03-13T09:49:07.161627Z","end":"2026-03-13T09:49:07.572028Z","steps":["trace[517949764] 'agreement among raft nodes before linearized reading'  (duration: 410.185112ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:07.572122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:49:07.161606Z","time spent":"410.507109ms","remote":"127.0.0.1:38028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-13T09:49:07.933285Z","caller":"traceutil/trace.go:171","msg":"trace[255054244] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"106.33198ms","start":"2026-03-13T09:49:07.826917Z","end":"2026-03-13T09:49:07.933249Z","steps":["trace[255054244] 'process raft request'  (duration: 105.722927ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:49:07.933592Z","caller":"traceutil/trace.go:171","msg":"trace[1166900908] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"101.640334ms","start":"2026-03-13T09:49:07.831934Z","end":"2026-03-13T09:49:07.933575Z","steps":["trace[1166900908] 'process raft request'  (duration: 101.244856ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:49:08.126485Z","caller":"traceutil/trace.go:171","msg":"trace[368542025] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"105.915143ms","start":"2026-03-13T09:49:08.020541Z","end":"2026-03-13T09:49:08.126456Z","steps":["trace[368542025] 'process raft request'  (duration: 105.73705ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:49:08.331149Z","caller":"traceutil/trace.go:171","msg":"trace[2034091260] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"169.098567ms","start":"2026-03-13T09:49:08.162019Z","end":"2026-03-13T09:49:08.331118Z","steps":["trace[2034091260] 'read index received'  (duration: 168.75331ms)","trace[2034091260] 'applied index is now lower than readState.Index'  (duration: 343.907µs)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:49:08.331216Z","caller":"traceutil/trace.go:171","msg":"trace[1125991222] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"183.069409ms","start":"2026-03-13T09:49:08.148133Z","end":"2026-03-13T09:49:08.331202Z","steps":["trace[1125991222] 'process raft request'  (duration: 182.742792ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:49:08.331343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.300221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-13T09:49:08.331403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.111447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-13T09:49:08.331414Z","caller":"traceutil/trace.go:171","msg":"trace[477776855] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"169.427143ms","start":"2026-03-13T09:49:08.161971Z","end":"2026-03-13T09:49:08.331398Z","steps":["trace[477776855] 'agreement among raft nodes before linearized reading'  (duration: 169.311131ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:49:08.331433Z","caller":"traceutil/trace.go:171","msg":"trace[2034236939] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"105.23331ms","start":"2026-03-13T09:49:08.226193Z","end":"2026-03-13T09:49:08.331426Z","steps":["trace[2034236939] 'agreement among raft nodes before linearized reading'  (duration: 105.138348ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:49:36.30911Z","caller":"traceutil/trace.go:171","msg":"trace[1697751933] linearizableReadLoop","detail":"{readStateIndex:828; appliedIndex:827; }","duration":"136.723634ms","start":"2026-03-13T09:49:36.172363Z","end":"2026-03-13T09:49:36.309086Z","steps":["trace[1697751933] 'read index received'  (duration: 136.516181ms)","trace[1697751933] 'applied index is now lower than readState.Index'  (duration: 206.583µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T09:49:36.309246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.871476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-13T09:49:36.309279Z","caller":"traceutil/trace.go:171","msg":"trace[575497757] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"136.978358ms","start":"2026-03-13T09:49:36.17229Z","end":"2026-03-13T09:49:36.309269Z","steps":["trace[575497757] 'agreement among raft nodes before linearized reading'  (duration: 136.903877ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:49:36.309258Z","caller":"traceutil/trace.go:171","msg":"trace[938338340] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"158.278765ms","start":"2026-03-13T09:49:36.150938Z","end":"2026-03-13T09:49:36.309216Z","steps":["trace[938338340] 'process raft request'  (duration: 158.000751ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:50:23.011205Z","caller":"traceutil/trace.go:171","msg":"trace[103752011] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"100.83826ms","start":"2026-03-13T09:50:22.910332Z","end":"2026-03-13T09:50:23.01117Z","steps":["trace[103752011] 'process raft request'  (duration: 100.493496ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:50:25.014201Z","caller":"traceutil/trace.go:171","msg":"trace[502248193] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"237.350122ms","start":"2026-03-13T09:50:24.776818Z","end":"2026-03-13T09:50:25.014169Z","steps":["trace[502248193] 'process raft request'  (duration: 193.748829ms)","trace[502248193] 'compare'  (duration: 43.303049ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:50:26.565453Z","caller":"traceutil/trace.go:171","msg":"trace[797700853] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"247.70278ms","start":"2026-03-13T09:50:26.317727Z","end":"2026-03-13T09:50:26.565429Z","steps":["trace[797700853] 'process raft request'  (duration: 247.629809ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:50:26.565495Z","caller":"traceutil/trace.go:171","msg":"trace[585697502] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"248.012743ms","start":"2026-03-13T09:50:26.317458Z","end":"2026-03-13T09:50:26.565471Z","steps":["trace[585697502] 'process raft request'  (duration: 245.131757ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:50:28.740832Z","caller":"traceutil/trace.go:171","msg":"trace[1160790203] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"109.57066ms","start":"2026-03-13T09:50:28.63124Z","end":"2026-03-13T09:50:28.740811Z","steps":["trace[1160790203] 'process raft request'  (duration: 97.999054ms)","trace[1160790203] 'compare'  (duration: 11.476805ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:50:29.271857Z","caller":"traceutil/trace.go:171","msg":"trace[1807785320] linearizableReadLoop","detail":"{readStateIndex:1017; appliedIndex:1016; }","duration":"111.128674ms","start":"2026-03-13T09:50:29.160708Z","end":"2026-03-13T09:50:29.271836Z","steps":["trace[1807785320] 'read index received'  (duration: 110.965692ms)","trace[1807785320] 'applied index is now lower than readState.Index'  (duration: 162.172µs)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:50:29.271985Z","caller":"traceutil/trace.go:171","msg":"trace[1818483642] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"186.244188ms","start":"2026-03-13T09:50:29.085704Z","end":"2026-03-13T09:50:29.271948Z","steps":["trace[1818483642] 'process raft request'  (duration: 186.013905ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:50:29.27201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.293126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-13T09:50:29.272199Z","caller":"traceutil/trace.go:171","msg":"trace[1741889779] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:975; }","duration":"111.511369ms","start":"2026-03-13T09:50:29.160662Z","end":"2026-03-13T09:50:29.272173Z","steps":["trace[1741889779] 'agreement among raft nodes before linearized reading'  (duration: 111.255566ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:50:33.396826Z","caller":"traceutil/trace.go:171","msg":"trace[1162258903] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"189.739588ms","start":"2026-03-13T09:50:33.207059Z","end":"2026-03-13T09:50:33.396799Z","steps":["trace[1162258903] 'process raft request'  (duration: 189.615717ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:50:43.917389Z","caller":"traceutil/trace.go:171","msg":"trace[173657160] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"375.144409ms","start":"2026-03-13T09:50:43.542193Z","end":"2026-03-13T09:50:43.917338Z","steps":["trace[173657160] 'process raft request'  (duration: 374.807876ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:50:43.917563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:50:43.542163Z","time spent":"375.312112ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1014 > 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-13T09:50:44.483403Z","caller":"traceutil/trace.go:171","msg":"trace[327739757] linearizableReadLoop","detail":"{readStateIndex:1067; appliedIndex:1066; }","duration":"321.840616ms","start":"2026-03-13T09:50:44.161541Z","end":"2026-03-13T09:50:44.483382Z","steps":["trace[327739757] 'read index received'  (duration: 321.667624ms)","trace[327739757] 'applied index is now lower than readState.Index'  (duration: 172.122µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T09:50:44.483524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.975487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-13T09:50:44.483556Z","caller":"traceutil/trace.go:171","msg":"trace[2026935687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1022; }","duration":"322.053018ms","start":"2026-03-13T09:50:44.161492Z","end":"2026-03-13T09:50:44.483545Z","steps":["trace[2026935687] 'agreement among raft nodes before linearized reading'  (duration: 321.970217ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:50:44.483594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:50:44.16147Z","time spent":"322.116139ms","remote":"127.0.0.1:38042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-13T09:50:44.484215Z","caller":"traceutil/trace.go:171","msg":"trace[30385746] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"559.847793ms","start":"2026-03-13T09:50:43.924327Z","end":"2026-03-13T09:50:44.484175Z","steps":["trace[30385746] 'process raft request'  (duration: 558.930232ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:50:44.484559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T09:50:43.924312Z","time spent":"560.112646ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1017 > 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-13T09:50:52.997263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.711136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-account-controller\" ","response":"range_response_count:1 size:677"}
{"level":"info","ts":"2026-03-13T09:50:52.997357Z","caller":"traceutil/trace.go:171","msg":"trace[1625714489] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-account-controller; range_end:; response_count:1; response_revision:1050; }","duration":"142.846258ms","start":"2026-03-13T09:50:52.854487Z","end":"2026-03-13T09:50:52.997334Z","steps":["trace[1625714489] 'range keys from in-memory index tree'  (duration: 142.610436ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:50:53.226739Z","caller":"traceutil/trace.go:171","msg":"trace[770171830] linearizableReadLoop","detail":"{readStateIndex:1099; appliedIndex:1097; }","duration":"160.323116ms","start":"2026-03-13T09:50:53.06638Z","end":"2026-03-13T09:50:53.226703Z","steps":["trace[770171830] 'read index received'  (duration: 7.217374ms)","trace[770171830] 'applied index is now lower than readState.Index'  (duration: 153.104242ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-13T09:50:53.226977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.891077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-account-controller\" ","response":"range_response_count:1 size:677"}
{"level":"warn","ts":"2026-03-13T09:50:53.226966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.559658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-controller\" ","response":"range_response_count:1 size:724"}
{"level":"info","ts":"2026-03-13T09:50:53.227063Z","caller":"traceutil/trace.go:171","msg":"trace[366507053] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-account-controller; range_end:; response_count:1; response_revision:1052; }","duration":"158.005128ms","start":"2026-03-13T09:50:53.069042Z","end":"2026-03-13T09:50:53.227047Z","steps":["trace[366507053] 'agreement among raft nodes before linearized reading'  (duration: 157.843967ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:50:53.227091Z","caller":"traceutil/trace.go:171","msg":"trace[427834558] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-controller; range_end:; response_count:1; response_revision:1052; }","duration":"160.73185ms","start":"2026-03-13T09:50:53.06633Z","end":"2026-03-13T09:50:53.227062Z","steps":["trace[427834558] 'agreement among raft nodes before linearized reading'  (duration: 160.509757ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:50:53.226818Z","caller":"traceutil/trace.go:171","msg":"trace[1830488068] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"224.949849ms","start":"2026-03-13T09:50:53.001824Z","end":"2026-03-13T09:50:53.226774Z","steps":["trace[1830488068] 'process raft request'  (duration: 224.637376ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:50:59.817195Z","caller":"traceutil/trace.go:171","msg":"trace[827158328] linearizableReadLoop","detail":"{readStateIndex:1118; appliedIndex:1117; }","duration":"237.45084ms","start":"2026-03-13T09:50:59.579719Z","end":"2026-03-13T09:50:59.817169Z","steps":["trace[827158328] 'read index received'  (duration: 237.289149ms)","trace[827158328] 'applied index is now lower than readState.Index'  (duration: 160.501µs)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:50:59.817231Z","caller":"traceutil/trace.go:171","msg":"trace[1317563733] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"240.93049ms","start":"2026-03-13T09:50:59.576264Z","end":"2026-03-13T09:50:59.817194Z","steps":["trace[1317563733] 'process raft request'  (duration: 240.720757ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:50:59.817408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.933599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"warn","ts":"2026-03-13T09:50:59.817419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.660983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-public\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-13T09:50:59.8175Z","caller":"traceutil/trace.go:171","msg":"trace[1222549359] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:1070; }","duration":"180.05196ms","start":"2026-03-13T09:50:59.637424Z","end":"2026-03-13T09:50:59.817476Z","steps":["trace[1222549359] 'agreement among raft nodes before linearized reading'  (duration: 179.906008ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:50:59.817512Z","caller":"traceutil/trace.go:171","msg":"trace[1135882268] range","detail":"{range_begin:/registry/namespaces/kube-public; range_end:; response_count:1; response_revision:1070; }","duration":"237.825024ms","start":"2026-03-13T09:50:59.579663Z","end":"2026-03-13T09:50:59.817488Z","steps":["trace[1135882268] 'agreement among raft nodes before linearized reading'  (duration: 237.640762ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:51:02.24602Z","caller":"traceutil/trace.go:171","msg":"trace[1725558642] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"101.078766ms","start":"2026-03-13T09:51:02.144907Z","end":"2026-03-13T09:51:02.245986Z","steps":["trace[1725558642] 'process raft request'  (duration: 100.632891ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:51:11.508845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.694922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"}
{"level":"info","ts":"2026-03-13T09:51:11.509016Z","caller":"traceutil/trace.go:171","msg":"trace[1251007284] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:1103; }","duration":"103.932924ms","start":"2026-03-13T09:51:11.405058Z","end":"2026-03-13T09:51:11.508991Z","steps":["trace[1251007284] 'range keys from in-memory index tree'  (duration: 103.54055ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:51:11.683171Z","caller":"traceutil/trace.go:171","msg":"trace[602858064] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"169.540377ms","start":"2026-03-13T09:51:11.513591Z","end":"2026-03-13T09:51:11.683131Z","steps":["trace[602858064] 'process raft request'  (duration: 169.191723ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T09:51:16.5632Z","caller":"traceutil/trace.go:171","msg":"trace[882392708] linearizableReadLoop","detail":"{readStateIndex:1168; appliedIndex:1167; }","duration":"110.669016ms","start":"2026-03-13T09:51:16.452492Z","end":"2026-03-13T09:51:16.563161Z","steps":["trace[882392708] 'read index received'  (duration: 110.344792ms)","trace[882392708] 'applied index is now lower than readState.Index'  (duration: 323.024µs)"],"step_count":2}
{"level":"info","ts":"2026-03-13T09:51:16.563297Z","caller":"traceutil/trace.go:171","msg":"trace[1274003738] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"116.065325ms","start":"2026-03-13T09:51:16.447187Z","end":"2026-03-13T09:51:16.563252Z","steps":["trace[1274003738] 'process raft request'  (duration: 115.754771ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T09:51:16.563534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.014469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-v2dm5\" ","response":"range_response_count:1 size:18525"}
{"level":"info","ts":"2026-03-13T09:51:16.5636Z","caller":"traceutil/trace.go:171","msg":"trace[1919319110] range","detail":"{range_begin:/registry/pods/kube-system/cilium-v2dm5; range_end:; response_count:1; response_revision:1116; }","duration":"111.11749ms","start":"2026-03-13T09:51:16.452468Z","end":"2026-03-13T09:51:16.563585Z","steps":["trace[1919319110] 'agreement among raft nodes before linearized reading'  (duration: 110.879828ms)"],"step_count":1}