{"level":"warn","ts":"2026-02-25T06:01:55.840495Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T06:01:55.840591Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-02-25T06:01:55.840669Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T06:01:55.84068Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]}
{"level":"info","ts":"2026-02-25T06:01:55.840735Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-25T06:01:55.841622Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]}
{"level":"info","ts":"2026-02-25T06:01:55.841724Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-02-25T06:01:55.847908Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.906909ms"}
{"level":"info","ts":"2026-02-25T06:01:55.856359Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"}
{"level":"info","ts":"2026-02-25T06:01:55.85645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T06:01:55.856477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"}
{"level":"info","ts":"2026-02-25T06:01:55.85649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T06:01:55.856505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"}
{"level":"info","ts":"2026-02-25T06:01:55.856547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"}
{"level":"warn","ts":"2026-02-25T06:01:55.862287Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T06:01:55.863471Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T06:01:55.864914Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-02-25T06:01:55.866802Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T06:01:55.867567Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T06:01:55.868052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"}
{"level":"info","ts":"2026-02-25T06:01:55.867741Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-25T06:01:55.868523Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]}
{"level":"info","ts":"2026-02-25T06:01:55.86903Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-25T06:01:55.8691Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-25T06:01:55.871746Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-25T06:01:55.871824Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"}
{"level":"info","ts":"2026-02-25T06:01:55.871884Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"}
{"level":"info","ts":"2026-02-25T06:01:55.872098Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T06:01:55.872141Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T06:01:56.156846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T06:01:56.157031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T06:01:56.157109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"}
{"level":"info","ts":"2026-02-25T06:01:56.157159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"}
{"level":"info","ts":"2026-02-25T06:01:56.157179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"}
{"level":"info","ts":"2026-02-25T06:01:56.157203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"}
{"level":"info","ts":"2026-02-25T06:01:56.157357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"}
{"level":"info","ts":"2026-02-25T06:01:56.15965Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T06:01:56.159668Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T06:01:56.159867Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T06:01:56.159928Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T06:01:56.160611Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T06:01:56.160763Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T06:01:56.160799Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T06:01:56.163293Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-25T06:01:56.165188Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"}
{"level":"info","ts":"2026-02-25T06:01:56.165381Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T06:01:56.165426Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T06:01:58.195522Z","caller":"traceutil/trace.go:171","msg":"trace[1256067272] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"138.258097ms","start":"2026-02-25T06:01:58.0572Z","end":"2026-02-25T06:01:58.195458Z","steps":["trace[1256067272] 'process raft request'  (duration: 137.978194ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:09.310222Z","caller":"traceutil/trace.go:171","msg":"trace[1610287093] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"451.985207ms","start":"2026-02-25T06:02:08.858216Z","end":"2026-02-25T06:02:09.310201Z","steps":["trace[1610287093] 'process raft request'  (duration: 451.612343ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:09.310982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:08.858198Z","time spent":"452.107658ms","remote":"127.0.0.1:39532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:393 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-25T06:02:10.646329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.116682855s","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101329586787204 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:38e19c9363c79383>","response":"size:40"}
{"level":"info","ts":"2026-02-25T06:02:10.646453Z","caller":"traceutil/trace.go:171","msg":"trace[72133695] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:417; }","duration":"1.049700554s","start":"2026-02-25T06:02:09.59673Z","end":"2026-02-25T06:02:10.64643Z","steps":["trace[72133695] 'read index received'  (duration: 32.02µs)","trace[72133695] 'applied index is now lower than readState.Index'  (duration: 1.049666694s)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:02:10.646621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.48297ms","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-02-25T06:02:10.64662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.049882877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-25T06:02:10.646663Z","caller":"traceutil/trace.go:171","msg":"trace[1643978976] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:404; }","duration":"363.573942ms","start":"2026-02-25T06:02:10.283078Z","end":"2026-02-25T06:02:10.646652Z","steps":["trace[1643978976] 'agreement among raft nodes before linearized reading'  (duration: 363.479131ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:10.646675Z","caller":"traceutil/trace.go:171","msg":"trace[387209786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:404; }","duration":"1.049964977s","start":"2026-02-25T06:02:09.596697Z","end":"2026-02-25T06:02:10.646662Z","steps":["trace[387209786] 'agreement among raft nodes before linearized reading'  (duration: 1.049857626s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:10.646698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:10.283039Z","time spent":"363.651072ms","remote":"127.0.0.1:39532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T06:02:10.646717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:09.596682Z","time spent":"1.050023848s","remote":"127.0.0.1:39532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T06:02:10.646843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.370005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:02:10.646896Z","caller":"traceutil/trace.go:171","msg":"trace[946537697] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:404; }","duration":"250.454045ms","start":"2026-02-25T06:02:10.396429Z","end":"2026-02-25T06:02:10.646883Z","steps":["trace[946537697] 'agreement among raft nodes before linearized reading'  (duration: 250.386335ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:10.646921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.26799ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T06:02:10.646489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:09.312076Z","time spent":"1.33439008s","remote":"127.0.0.1:39300","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-25T06:02:10.647114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.859488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T06:02:10.646993Z","caller":"traceutil/trace.go:171","msg":"trace[734439429] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:404; }","duration":"361.34047ms","start":"2026-02-25T06:02:10.285644Z","end":"2026-02-25T06:02:10.646985Z","steps":["trace[734439429] 'agreement among raft nodes before linearized reading'  (duration: 361.256819ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:10.647173Z","caller":"traceutil/trace.go:171","msg":"trace[426215170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:404; }","duration":"176.94253ms","start":"2026-02-25T06:02:10.470217Z","end":"2026-02-25T06:02:10.647159Z","steps":["trace[426215170] 'agreement among raft nodes before linearized reading'  (duration: 176.850709ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:11.149588Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101329586787208,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T06:02:11.432704Z","caller":"traceutil/trace.go:171","msg":"trace[860508113] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"784.158494ms","start":"2026-02-25T06:02:10.64852Z","end":"2026-02-25T06:02:11.432678Z","steps":["trace[860508113] 'process raft request'  (duration: 752.423503ms)","trace[860508113] 'compare'  (duration: 31.62277ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:02:11.432858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:10.648496Z","time spent":"784.278475ms","remote":"127.0.0.1:39300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.57\" mod_revision:195 > success:<request_put:<key:\"/registry/masterleases/199.204.45.57\" value_size:66 lease:4098729292732011395 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.57\" > >"}
{"level":"info","ts":"2026-02-25T06:02:11.437232Z","caller":"traceutil/trace.go:171","msg":"trace[94960565] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"786.293214ms","start":"2026-02-25T06:02:10.650925Z","end":"2026-02-25T06:02:11.437218Z","steps":["trace[94960565] 'process raft request'  (duration: 786.185163ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:11.437318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:10.650915Z","time spent":"786.361785ms","remote":"127.0.0.1:39532","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:400 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-25T06:02:11.4376Z","caller":"traceutil/trace.go:171","msg":"trace[1970677981] linearizableReadLoop","detail":"{readStateIndex:422; appliedIndex:418; }","duration":"788.305374ms","start":"2026-02-25T06:02:10.649265Z","end":"2026-02-25T06:02:11.437571Z","steps":["trace[1970677981] 'read index received'  (duration: 751.793207ms)","trace[1970677981] 'applied index is now lower than readState.Index'  (duration: 36.511157ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:02:11.43766Z","caller":"traceutil/trace.go:171","msg":"trace[827709140] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"786.599737ms","start":"2026-02-25T06:02:10.651042Z","end":"2026-02-25T06:02:11.437642Z","steps":["trace[827709140] 'process raft request'  (duration: 786.144693ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:11.437713Z","caller":"traceutil/trace.go:171","msg":"trace[455966764] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"786.090422ms","start":"2026-02-25T06:02:10.651612Z","end":"2026-02-25T06:02:11.437703Z","steps":["trace[455966764] 'process raft request'  (duration: 785.769299ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:11.437733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:10.651037Z","time spent":"786.659718ms","remote":"127.0.0.1:39532","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:402 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T06:02:11.437758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"788.483085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5260"}
{"level":"info","ts":"2026-02-25T06:02:11.437804Z","caller":"traceutil/trace.go:171","msg":"trace[1635917773] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:409; }","duration":"788.548736ms","start":"2026-02-25T06:02:10.649242Z","end":"2026-02-25T06:02:11.43779Z","steps":["trace[1635917773] 'agreement among raft nodes before linearized reading'  (duration: 788.474215ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:11.437833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:10.64923Z","time spent":"788.595976ms","remote":"127.0.0.1:39472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5283,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "}
{"level":"warn","ts":"2026-02-25T06:02:11.437825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:10.651603Z","time spent":"786.141552ms","remote":"127.0.0.1:39532","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:403 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-25T06:02:11.437962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.325451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T06:02:11.437965Z","caller":"traceutil/trace.go:171","msg":"trace[1639784903] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"157.95777ms","start":"2026-02-25T06:02:11.279997Z","end":"2026-02-25T06:02:11.437955Z","steps":["trace[1639784903] 'process raft request'  (duration: 157.527296ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:11.438005Z","caller":"traceutil/trace.go:171","msg":"trace[1694086950] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:409; }","duration":"123.435432ms","start":"2026-02-25T06:02:11.31456Z","end":"2026-02-25T06:02:11.437996Z","steps":["trace[1694086950] 'agreement among raft nodes before linearized reading'  (duration: 123.368041ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:13.613585Z","caller":"traceutil/trace.go:171","msg":"trace[1429398645] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"169.145911ms","start":"2026-02-25T06:02:13.444412Z","end":"2026-02-25T06:02:13.613558Z","steps":["trace[1429398645] 'process raft request'  (duration: 124.671668ms)","trace[1429398645] 'compare'  (duration: 44.230691ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:02:13.61383Z","caller":"traceutil/trace.go:171","msg":"trace[621085248] linearizableReadLoop","detail":"{readStateIndex:432; appliedIndex:429; }","duration":"165.730439ms","start":"2026-02-25T06:02:13.448055Z","end":"2026-02-25T06:02:13.613785Z","steps":["trace[621085248] 'read index received'  (duration: 13.358904ms)","trace[621085248] 'applied index is now lower than readState.Index'  (duration: 152.368545ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:02:13.613917Z","caller":"traceutil/trace.go:171","msg":"trace[783718730] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"168.085871ms","start":"2026-02-25T06:02:13.445792Z","end":"2026-02-25T06:02:13.613878Z","steps":["trace[783718730] 'process raft request'  (duration: 167.724198ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:13.614054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.963891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T06:02:13.614111Z","caller":"traceutil/trace.go:171","msg":"trace[1830076967] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:418; }","duration":"166.077963ms","start":"2026-02-25T06:02:13.448005Z","end":"2026-02-25T06:02:13.614083Z","steps":["trace[1830076967] 'agreement among raft nodes before linearized reading'  (duration: 165.920052ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:19.671Z","caller":"traceutil/trace.go:171","msg":"trace[2146180496] linearizableReadLoop","detail":"{readStateIndex:474; appliedIndex:473; }","duration":"264.715816ms","start":"2026-02-25T06:02:19.406262Z","end":"2026-02-25T06:02:19.670977Z","steps":["trace[2146180496] 'read index received'  (duration: 264.528725ms)","trace[2146180496] 'applied index is now lower than readState.Index'  (duration: 185.931µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:02:19.671097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:19.282239Z","time spent":"388.847222ms","remote":"127.0.0.1:39300","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-25T06:02:19.671193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.895538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T06:02:19.671226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.958887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-25T06:02:19.671302Z","caller":"traceutil/trace.go:171","msg":"trace[517883888] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:457; }","duration":"178.099128ms","start":"2026-02-25T06:02:19.493192Z","end":"2026-02-25T06:02:19.671291Z","steps":["trace[517883888] 'agreement among raft nodes before linearized reading'  (duration: 177.926027ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:19.671249Z","caller":"traceutil/trace.go:171","msg":"trace[539033834] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:457; }","duration":"265.02925ms","start":"2026-02-25T06:02:19.406199Z","end":"2026-02-25T06:02:19.671228Z","steps":["trace[539033834] 'agreement among raft nodes before linearized reading'  (duration: 264.871258ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:19.878036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.424719ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101329586787304 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.57\" mod_revision:405 > success:<request_put:<key:\"/registry/masterleases/199.204.45.57\" value_size:66 lease:4098729292732011491 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.57\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T06:02:19.878178Z","caller":"traceutil/trace.go:171","msg":"trace[1828046556] linearizableReadLoop","detail":"{readStateIndex:476; appliedIndex:474; }","duration":"196.789752ms","start":"2026-02-25T06:02:19.681378Z","end":"2026-02-25T06:02:19.878167Z","steps":["trace[1828046556] 'read index received'  (duration: 64.350003ms)","trace[1828046556] 'applied index is now lower than readState.Index'  (duration: 132.438869ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:02:19.878237Z","caller":"traceutil/trace.go:171","msg":"trace[49946337] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"205.557209ms","start":"2026-02-25T06:02:19.672674Z","end":"2026-02-25T06:02:19.878232Z","steps":["trace[49946337] 'process raft request'  (duration: 72.868078ms)","trace[49946337] 'compare'  (duration: 132.324448ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:02:19.878391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.488549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-25T06:02:19.878442Z","caller":"traceutil/trace.go:171","msg":"trace[1381357574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:459; }","duration":"196.570841ms","start":"2026-02-25T06:02:19.681858Z","end":"2026-02-25T06:02:19.878428Z","steps":["trace[1381357574] 'agreement among raft nodes before linearized reading'  (duration: 196.421579ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:19.878418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.013844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T06:02:19.878498Z","caller":"traceutil/trace.go:171","msg":"trace[1339322500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:459; }","duration":"197.168245ms","start":"2026-02-25T06:02:19.681311Z","end":"2026-02-25T06:02:19.878479Z","steps":["trace[1339322500] 'agreement among raft nodes before linearized reading'  (duration: 196.934603ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:19.878554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.9894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T06:02:19.878585Z","caller":"traceutil/trace.go:171","msg":"trace[1716952750] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:459; }","duration":"168.02047ms","start":"2026-02-25T06:02:19.710558Z","end":"2026-02-25T06:02:19.878579Z","steps":["trace[1716952750] 'agreement among raft nodes before linearized reading'  (duration: 167.97351ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:19.878636Z","caller":"traceutil/trace.go:171","msg":"trace[1282379042] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"202.986996ms","start":"2026-02-25T06:02:19.675645Z","end":"2026-02-25T06:02:19.878632Z","steps":["trace[1282379042] 'process raft request'  (duration: 202.472122ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:20.092457Z","caller":"traceutil/trace.go:171","msg":"trace[126009270] linearizableReadLoop","detail":"{readStateIndex:478; appliedIndex:476; }","duration":"208.586188ms","start":"2026-02-25T06:02:19.883847Z","end":"2026-02-25T06:02:20.092433Z","steps":["trace[126009270] 'read index received'  (duration: 53.205506ms)","trace[126009270] 'applied index is now lower than readState.Index'  (duration: 155.379422ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:02:20.092529Z","caller":"traceutil/trace.go:171","msg":"trace[678914896] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"208.93214ms","start":"2026-02-25T06:02:19.883541Z","end":"2026-02-25T06:02:20.092474Z","steps":["trace[678914896] 'process raft request'  (duration: 132.265926ms)","trace[678914896] 'compare'  (duration: 76.451012ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:02:20.092612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.736079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-02-25T06:02:20.09265Z","caller":"traceutil/trace.go:171","msg":"trace[992464055] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:462; }","duration":"208.80191ms","start":"2026-02-25T06:02:19.883838Z","end":"2026-02-25T06:02:20.09264Z","steps":["trace[992464055] 'agreement among raft nodes before linearized reading'  (duration: 208.689139ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:20.092847Z","caller":"traceutil/trace.go:171","msg":"trace[580073107] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"208.420656ms","start":"2026-02-25T06:02:19.884368Z","end":"2026-02-25T06:02:20.092789Z","steps":["trace[580073107] 'process raft request'  (duration: 208.019652ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:26.226888Z","caller":"traceutil/trace.go:171","msg":"trace[608785168] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:525; }","duration":"109.917236ms","start":"2026-02-25T06:02:26.116947Z","end":"2026-02-25T06:02:26.226864Z","steps":["trace[608785168] 'read index received'  (duration: 50.461796ms)","trace[608785168] 'applied index is now lower than readState.Index'  (duration: 59.45433ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:02:26.226999Z","caller":"traceutil/trace.go:171","msg":"trace[84522457] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"251.115011ms","start":"2026-02-25T06:02:25.975851Z","end":"2026-02-25T06:02:26.226966Z","steps":["trace[84522457] 'process raft request'  (duration: 191.5329ms)","trace[84522457] 'compare'  (duration: 59.354059ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:02:26.22706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.101507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-25T06:02:26.227097Z","caller":"traceutil/trace.go:171","msg":"trace[1939126988] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:507; }","duration":"110.201208ms","start":"2026-02-25T06:02:26.116884Z","end":"2026-02-25T06:02:26.227085Z","steps":["trace[1939126988] 'agreement among raft nodes before linearized reading'  (duration: 110.109497ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:26.227141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.395641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-25T06:02:26.227175Z","caller":"traceutil/trace.go:171","msg":"trace[1006665076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:507; }","duration":"109.451601ms","start":"2026-02-25T06:02:26.117714Z","end":"2026-02-25T06:02:26.227165Z","steps":["trace[1006665076] 'agreement among raft nodes before linearized reading'  (duration: 109.386331ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:34.315163Z","caller":"traceutil/trace.go:171","msg":"trace[43409106] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"270.985996ms","start":"2026-02-25T06:02:34.044143Z","end":"2026-02-25T06:02:34.315129Z","steps":["trace[43409106] 'process raft request'  (duration: 270.824705ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:34.731136Z","caller":"traceutil/trace.go:171","msg":"trace[256723634] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"412.402426ms","start":"2026-02-25T06:02:34.318703Z","end":"2026-02-25T06:02:34.731105Z","steps":["trace[256723634] 'process raft request'  (duration: 374.447301ms)","trace[256723634] 'compare'  (duration: 37.707523ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:02:34.731237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:34.318677Z","time spent":"412.510137ms","remote":"127.0.0.1:39532","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:545 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-25T06:02:34.806448Z","caller":"traceutil/trace.go:171","msg":"trace[1002890217] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"487.078665ms","start":"2026-02-25T06:02:34.319346Z","end":"2026-02-25T06:02:34.806425Z","steps":["trace[1002890217] 'process raft request'  (duration: 486.919434ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:34.806587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:34.319331Z","time spent":"487.188526ms","remote":"127.0.0.1:39532","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:546 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T06:02:34.806691Z","caller":"traceutil/trace.go:171","msg":"trace[1120884186] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"487.198156ms","start":"2026-02-25T06:02:34.319474Z","end":"2026-02-25T06:02:34.806673Z","steps":["trace[1120884186] 'process raft request'  (duration: 486.911294ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:34.806812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:34.319469Z","time spent":"487.275657ms","remote":"127.0.0.1:39532","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:547 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-25T06:02:34.807281Z","caller":"traceutil/trace.go:171","msg":"trace[1713355317] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"479.649408ms","start":"2026-02-25T06:02:34.327461Z","end":"2026-02-25T06:02:34.80711Z","steps":["trace[1713355317] 'process raft request'  (duration: 479.183614ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:34.807324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:34.327443Z","time spent":"479.863699ms","remote":"127.0.0.1:39472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-jqbc6\" mod_revision:500 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-jqbc6\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-jqbc6\" > >"}
{"level":"info","ts":"2026-02-25T06:02:36.462803Z","caller":"traceutil/trace.go:171","msg":"trace[935017239] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"139.574891ms","start":"2026-02-25T06:02:36.323211Z","end":"2026-02-25T06:02:36.462786Z","steps":["trace[935017239] 'process raft request'  (duration: 139.209548ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:38.588052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.873867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-25T06:02:38.588135Z","caller":"traceutil/trace.go:171","msg":"trace[1521138581] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"121.010548ms","start":"2026-02-25T06:02:38.467105Z","end":"2026-02-25T06:02:38.588116Z","steps":["trace[1521138581] 'range keys from in-memory index tree'  (duration: 120.668345ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:38.942972Z","caller":"traceutil/trace.go:171","msg":"trace[2033341546] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"472.827325ms","start":"2026-02-25T06:02:38.470126Z","end":"2026-02-25T06:02:38.942954Z","steps":["trace[2033341546] 'process raft request'  (duration: 472.738865ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:38.943081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:38.47011Z","time spent":"472.917336ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" value_size:12154 >> failure:<>"}
{"level":"info","ts":"2026-02-25T06:02:38.94956Z","caller":"traceutil/trace.go:171","msg":"trace[951258391] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"277.101211ms","start":"2026-02-25T06:02:38.672448Z","end":"2026-02-25T06:02:38.949549Z","steps":["trace[951258391] 'read index received'  (duration: 270.536632ms)","trace[951258391] 'applied index is now lower than readState.Index'  (duration: 6.563829ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:02:38.949901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.251437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-25T06:02:38.949944Z","caller":"traceutil/trace.go:171","msg":"trace[505329020] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"357.856693ms","start":"2026-02-25T06:02:38.592073Z","end":"2026-02-25T06:02:38.94993Z","steps":["trace[505329020] 'process raft request'  (duration: 357.39616ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:38.950017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:38.592054Z","time spent":"357.921285ms","remote":"127.0.0.1:39532","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:556 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T06:02:38.950043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.802282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T06:02:38.950076Z","caller":"traceutil/trace.go:171","msg":"trace[938718829] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"130.859192ms","start":"2026-02-25T06:02:38.819208Z","end":"2026-02-25T06:02:38.950067Z","steps":["trace[938718829] 'agreement among raft nodes before linearized reading'  (duration: 130.761122ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:38.949945Z","caller":"traceutil/trace.go:171","msg":"trace[905594670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:591; }","duration":"205.343527ms","start":"2026-02-25T06:02:38.744593Z","end":"2026-02-25T06:02:38.949937Z","steps":["trace[905594670] 'agreement among raft nodes before linearized reading'  (duration: 205.215186ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:38.949881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.403964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:02:38.950189Z","caller":"traceutil/trace.go:171","msg":"trace[1591899400] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:591; }","duration":"277.766906ms","start":"2026-02-25T06:02:38.672414Z","end":"2026-02-25T06:02:38.950181Z","steps":["trace[1591899400] 'agreement among raft nodes before linearized reading'  (duration: 277.386603ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:38.950243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.437227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T06:02:38.950306Z","caller":"traceutil/trace.go:171","msg":"trace[1545255596] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:591; }","duration":"131.539848ms","start":"2026-02-25T06:02:38.818751Z","end":"2026-02-25T06:02:38.95029Z","steps":["trace[1545255596] 'agreement among raft nodes before linearized reading'  (duration: 131.329016ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:41.59663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.646964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"}
{"level":"info","ts":"2026-02-25T06:02:41.596721Z","caller":"traceutil/trace.go:171","msg":"trace[690464389] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:628; }","duration":"130.812695ms","start":"2026-02-25T06:02:41.465891Z","end":"2026-02-25T06:02:41.596704Z","steps":["trace[690464389] 'range keys from in-memory index tree'  (duration: 130.479952ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:42.464258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.54809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"}
{"level":"info","ts":"2026-02-25T06:02:42.464349Z","caller":"traceutil/trace.go:171","msg":"trace[914011907] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:634; }","duration":"199.704831ms","start":"2026-02-25T06:02:42.264623Z","end":"2026-02-25T06:02:42.464328Z","steps":["trace[914011907] 'range keys from in-memory index tree'  (duration: 199.297728ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:42.47606Z","caller":"traceutil/trace.go:171","msg":"trace[828635357] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"196.821579ms","start":"2026-02-25T06:02:42.279218Z","end":"2026-02-25T06:02:42.476039Z","steps":["trace[828635357] 'read index received'  (duration: 196.224995ms)","trace[828635357] 'applied index is now lower than readState.Index'  (duration: 595.534µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:02:42.476159Z","caller":"traceutil/trace.go:171","msg":"trace[259566792] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"206.504391ms","start":"2026-02-25T06:02:42.269623Z","end":"2026-02-25T06:02:42.476128Z","steps":["trace[259566792] 'process raft request'  (duration: 205.990947ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:42.476279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.041151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-25T06:02:42.476316Z","caller":"traceutil/trace.go:171","msg":"trace[1602779357] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:635; }","duration":"197.116071ms","start":"2026-02-25T06:02:42.27919Z","end":"2026-02-25T06:02:42.476306Z","steps":["trace[1602779357] 'agreement among raft nodes before linearized reading'  (duration: 196.95137ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:42.543955Z","caller":"traceutil/trace.go:171","msg":"trace[1819546375] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"209.844426ms","start":"2026-02-25T06:02:42.334084Z","end":"2026-02-25T06:02:42.543928Z","steps":["trace[1819546375] 'process raft request'  (duration: 209.753845ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:42.544515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.403607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jqbc6\" ","response":"range_response_count:1 size:17914"}
{"level":"info","ts":"2026-02-25T06:02:42.544564Z","caller":"traceutil/trace.go:171","msg":"trace[380379637] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jqbc6; range_end:; response_count:1; response_revision:636; }","duration":"211.492479ms","start":"2026-02-25T06:02:42.333058Z","end":"2026-02-25T06:02:42.54455Z","steps":["trace[380379637] 'agreement among raft nodes before linearized reading'  (duration: 211.318557ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:42.544851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.488689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:02:42.544893Z","caller":"traceutil/trace.go:171","msg":"trace[1836727717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"149.561239ms","start":"2026-02-25T06:02:42.395321Z","end":"2026-02-25T06:02:42.544882Z","steps":["trace[1836727717] 'agreement among raft nodes before linearized reading'  (duration: 149.483508ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:46.362241Z","caller":"traceutil/trace.go:171","msg":"trace[1904391012] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"183.05382ms","start":"2026-02-25T06:02:46.179164Z","end":"2026-02-25T06:02:46.362217Z","steps":["trace[1904391012] 'process raft request'  (duration: 182.925589ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:46.503664Z","caller":"traceutil/trace.go:171","msg":"trace[1530292695] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"115.296058ms","start":"2026-02-25T06:02:46.388347Z","end":"2026-02-25T06:02:46.503643Z","steps":["trace[1530292695] 'process raft request'  (duration: 105.058234ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:46.754027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.665592ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101329586787739 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:662 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T06:02:46.754112Z","caller":"traceutil/trace.go:171","msg":"trace[371263021] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"192.106706ms","start":"2026-02-25T06:02:46.561993Z","end":"2026-02-25T06:02:46.7541Z","steps":["trace[371263021] 'process raft request'  (duration: 47.309793ms)","trace[371263021] 'compare'  (duration: 144.577261ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:02:46.975746Z","caller":"traceutil/trace.go:171","msg":"trace[1594060398] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"164.845339ms","start":"2026-02-25T06:02:46.810876Z","end":"2026-02-25T06:02:46.975721Z","steps":["trace[1594060398] 'process raft request'  (duration: 97.140986ms)","trace[1594060398] 'compare'  (duration: 67.524271ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:02:47.097902Z","caller":"traceutil/trace.go:171","msg":"trace[520933226] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:700; }","duration":"105.233772ms","start":"2026-02-25T06:02:46.992639Z","end":"2026-02-25T06:02:47.097873Z","steps":["trace[520933226] 'read index received'  (duration: 104.703568ms)","trace[520933226] 'applied index is now lower than readState.Index'  (duration: 528.914µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:02:47.098025Z","caller":"traceutil/trace.go:171","msg":"trace[1426296631] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"106.834034ms","start":"2026-02-25T06:02:46.99118Z","end":"2026-02-25T06:02:47.098014Z","steps":["trace[1426296631] 'process raft request'  (duration: 106.189149ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:47.098406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.756989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T06:02:47.098484Z","caller":"traceutil/trace.go:171","msg":"trace[886734760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:677; }","duration":"104.865579ms","start":"2026-02-25T06:02:46.993599Z","end":"2026-02-25T06:02:47.098465Z","steps":["trace[886734760] 'agreement among raft nodes before linearized reading'  (duration: 104.509677ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:47.098501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.841606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T06:02:47.098542Z","caller":"traceutil/trace.go:171","msg":"trace[913784266] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:677; }","duration":"105.922047ms","start":"2026-02-25T06:02:46.992606Z","end":"2026-02-25T06:02:47.098528Z","steps":["trace[913784266] 'agreement among raft nodes before linearized reading'  (duration: 105.759236ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:47.098779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.652564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-25T06:02:47.09883Z","caller":"traceutil/trace.go:171","msg":"trace[2040834578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:677; }","duration":"102.716864ms","start":"2026-02-25T06:02:46.996102Z","end":"2026-02-25T06:02:47.098819Z","steps":["trace[2040834578] 'agreement among raft nodes before linearized reading'  (duration: 102.574993ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:47.391035Z","caller":"traceutil/trace.go:171","msg":"trace[1648965375] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"176.370746ms","start":"2026-02-25T06:02:47.214641Z","end":"2026-02-25T06:02:47.391012Z","steps":["trace[1648965375] 'process raft request'  (duration: 176.213595ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:47.571716Z","caller":"traceutil/trace.go:171","msg":"trace[878161792] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"175.69679ms","start":"2026-02-25T06:02:47.395942Z","end":"2026-02-25T06:02:47.571639Z","steps":["trace[878161792] 'read index received'  (duration: 175.538749ms)","trace[878161792] 'applied index is now lower than readState.Index'  (duration: 157.011µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:02:47.571845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.893523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:02:47.571896Z","caller":"traceutil/trace.go:171","msg":"trace[1087841448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:682; }","duration":"175.996073ms","start":"2026-02-25T06:02:47.39589Z","end":"2026-02-25T06:02:47.571886Z","steps":["trace[1087841448] 'agreement among raft nodes before linearized reading'  (duration: 175.894523ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:47.57221Z","caller":"traceutil/trace.go:171","msg":"trace[666877835] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"344.358301ms","start":"2026-02-25T06:02:47.227788Z","end":"2026-02-25T06:02:47.572147Z","steps":["trace[666877835] 'process raft request'  (duration: 343.722207ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:47.572477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:47.227767Z","time spent":"344.490762ms","remote":"127.0.0.1:39472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18231,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-jqbc6\" mod_revision:661 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-jqbc6\" value_size:18182 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-jqbc6\" > >"}
{"level":"info","ts":"2026-02-25T06:02:47.681659Z","caller":"traceutil/trace.go:171","msg":"trace[895946377] linearizableReadLoop","detail":"{readStateIndex:707; appliedIndex:706; }","duration":"108.446114ms","start":"2026-02-25T06:02:47.57319Z","end":"2026-02-25T06:02:47.681636Z","steps":["trace[895946377] 'read index received'  (duration: 103.128155ms)","trace[895946377] 'applied index is now lower than readState.Index'  (duration: 5.317019ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:02:47.681784Z","caller":"traceutil/trace.go:171","msg":"trace[833401088] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"271.421803ms","start":"2026-02-25T06:02:47.410352Z","end":"2026-02-25T06:02:47.681774Z","steps":["trace[833401088] 'process raft request'  (duration: 266.020194ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:47.681959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.03893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jqbc6\" ","response":"range_response_count:1 size:18246"}
{"level":"info","ts":"2026-02-25T06:02:47.681995Z","caller":"traceutil/trace.go:171","msg":"trace[1745137457] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jqbc6; range_end:; response_count:1; response_revision:683; }","duration":"105.116001ms","start":"2026-02-25T06:02:47.57687Z","end":"2026-02-25T06:02:47.681986Z","steps":["trace[1745137457] 'agreement among raft nodes before linearized reading'  (duration: 104.960109ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:02:47.682097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.869577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:02:47.682278Z","caller":"traceutil/trace.go:171","msg":"trace[530145317] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:683; }","duration":"109.024409ms","start":"2026-02-25T06:02:47.573166Z","end":"2026-02-25T06:02:47.68219Z","steps":["trace[530145317] 'agreement among raft nodes before linearized reading'  (duration: 108.784497ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:47.867293Z","caller":"traceutil/trace.go:171","msg":"trace[550656537] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"170.626713ms","start":"2026-02-25T06:02:47.696638Z","end":"2026-02-25T06:02:47.867264Z","steps":["trace[550656537] 'process raft request'  (duration: 135.365508ms)","trace[550656537] 'compare'  (duration: 35.133154ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T06:02:48.021545Z","caller":"traceutil/trace.go:171","msg":"trace[311141642] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"140.159784ms","start":"2026-02-25T06:02:47.881361Z","end":"2026-02-25T06:02:48.021521Z","steps":["trace[311141642] 'process raft request'  (duration: 140.009213ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:02:48.245439Z","caller":"traceutil/trace.go:171","msg":"trace[1781998355] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"308.733954ms","start":"2026-02-25T06:02:47.93667Z","end":"2026-02-25T06:02:48.245404Z","steps":["trace[1781998355] 'process raft request'  (duration: 223.027098ms)","trace[1781998355] 'compare'  (duration: 85.473335ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:02:48.245631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:02:47.936653Z","time spent":"308.871156ms","remote":"127.0.0.1:39468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4439,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:685 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4405 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-25T06:04:09.379817Z","caller":"traceutil/trace.go:171","msg":"trace[1573230373] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"128.353818ms","start":"2026-02-25T06:04:09.251407Z","end":"2026-02-25T06:04:09.379761Z","steps":["trace[1573230373] 'process raft request'  (duration: 127.950726ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:04:09.837464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.700452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-02-25T06:04:09.837538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T06:04:09.837557Z","caller":"traceutil/trace.go:171","msg":"trace[1138795145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1006; }","duration":"125.855276ms","start":"2026-02-25T06:04:09.711681Z","end":"2026-02-25T06:04:09.837537Z","steps":["trace[1138795145] 'range keys from in-memory index tree'  (duration: 125.501196ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:04:09.837526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.915342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T06:04:09.837642Z","caller":"traceutil/trace.go:171","msg":"trace[1116719833] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1006; }","duration":"130.087647ms","start":"2026-02-25T06:04:09.707528Z","end":"2026-02-25T06:04:09.837615Z","steps":["trace[1116719833] 'range keys from in-memory index tree'  (duration: 129.685835ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:04:09.837588Z","caller":"traceutil/trace.go:171","msg":"trace[373519484] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1006; }","duration":"125.709402ms","start":"2026-02-25T06:04:09.711864Z","end":"2026-02-25T06:04:09.837574Z","steps":["trace[373519484] 'range keys from in-memory index tree'  (duration: 125.522966ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:04:10.897108Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101329586788599,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T06:04:11.096719Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.220363963s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T06:04:11.097291Z","caller":"traceutil/trace.go:171","msg":"trace[714319799] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"1.254391235s","start":"2026-02-25T06:04:09.842871Z","end":"2026-02-25T06:04:11.097262Z","steps":["trace[714319799] 'process raft request'  (duration: 1.254328274s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:04:11.09734Z","caller":"traceutil/trace.go:171","msg":"trace[187178718] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"1.255527868s","start":"2026-02-25T06:04:09.841786Z","end":"2026-02-25T06:04:11.097314Z","steps":["trace[187178718] 'process raft request'  (duration: 1.255204279s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:04:11.097528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:04:09.841759Z","time spent":"1.255693243s","remote":"127.0.0.1:39532","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:1000 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-25T06:04:11.097477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:04:09.842854Z","time spent":"1.254515189s","remote":"127.0.0.1:39532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1001 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-25T06:04:11.192059Z","caller":"traceutil/trace.go:171","msg":"trace[859576963] linearizableReadLoop","detail":"{readStateIndex:1053; appliedIndex:1050; }","duration":"795.247247ms","start":"2026-02-25T06:04:10.396787Z","end":"2026-02-25T06:04:11.192034Z","steps":["trace[859576963] 'read index received'  (duration: 700.218509ms)","trace[859576963] 'applied index is now lower than readState.Index'  (duration: 95.027948ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T06:04:11.192265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.460234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:04:11.192314Z","caller":"traceutil/trace.go:171","msg":"trace[409449997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1010; }","duration":"795.565917ms","start":"2026-02-25T06:04:10.396738Z","end":"2026-02-25T06:04:11.192304Z","steps":["trace[409449997] 'agreement among raft nodes before linearized reading'  (duration: 795.463694ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:04:11.192349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:04:10.396722Z","time spent":"795.619618ms","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T06:04:11.192443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.077133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T06:04:11.192122Z","caller":"traceutil/trace.go:171","msg":"trace[873409936] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"911.178551ms","start":"2026-02-25T06:04:10.280914Z","end":"2026-02-25T06:04:11.192093Z","steps":["trace[873409936] 'process raft request'  (duration: 903.509896ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T06:04:11.192555Z","caller":"traceutil/trace.go:171","msg":"trace[1011703777] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1010; }","duration":"258.215558ms","start":"2026-02-25T06:04:10.934291Z","end":"2026-02-25T06:04:11.192507Z","steps":["trace[1011703777] 'agreement among raft nodes before linearized reading'  (duration: 258.060633ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T06:04:11.192627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T06:04:10.280886Z","time spent":"911.647044ms","remote":"127.0.0.1:39532","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:975 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}