{"level":"warn","ts":"2026-02-02T17:40:54.016953Z","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-02T17:40:54.017517Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.250: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://162.253.55.250:2380","--initial-cluster=instance=https://162.253.55.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.250: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-02T17:40:54.017838Z","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-02T17:40:54.017914Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.250:2380"]}
{"level":"info","ts":"2026-02-02T17:40:54.017974Z","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-02T17:40:54.019163Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.250:2379"]}
{"level":"info","ts":"2026-02-02T17:40:54.01936Z","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":2,"max-cpu-available":2,"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://162.253.55.250:2380"],"listen-peer-urls":["https://162.253.55.250:2380"],"advertise-client-urls":["https://162.253.55.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.250: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-02T17:40:54.079162Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"51.634355ms"}
{"level":"info","ts":"2026-02-02T17:40:54.109816Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1e4a0bccff66c64d","cluster-id":"8ba64f6e83da771"}
{"level":"info","ts":"2026-02-02T17:40:54.109968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d switched to configuration voters=()"}
{"level":"info","ts":"2026-02-02T17:40:54.110017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became follower at term 0"}
{"level":"info","ts":"2026-02-02T17:40:54.110042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1e4a0bccff66c64d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-02T17:40:54.110063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became follower at term 1"}
{"level":"info","ts":"2026-02-02T17:40:54.110136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d switched to configuration voters=(2182569944500586061)"}
{"level":"warn","ts":"2026-02-02T17:40:54.119444Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-02T17:40:54.131341Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-02T17:40:54.144721Z","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-02T17:40:54.162007Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1e4a0bccff66c64d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-02T17:40:54.175599Z","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-02T17:40:54.179466Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1e4a0bccff66c64d","initial-advertise-peer-urls":["https://162.253.55.250:2380"],"listen-peer-urls":["https://162.253.55.250:2380"],"advertise-client-urls":["https://162.253.55.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-02T17:40:54.179515Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-02T17:40:54.179584Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1e4a0bccff66c64d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-02T17:40:54.179801Z","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-02T17:40:54.179865Z","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-02T17:40:54.179935Z","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-02T17:40:54.180177Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.250:2380"}
{"level":"info","ts":"2026-02-02T17:40:54.180192Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.250:2380"}
{"level":"info","ts":"2026-02-02T17:40:54.184418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d switched to configuration voters=(2182569944500586061)"}
{"level":"info","ts":"2026-02-02T17:40:54.184545Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ba64f6e83da771","local-member-id":"1e4a0bccff66c64d","added-peer-id":"1e4a0bccff66c64d","added-peer-peer-urls":["https://162.253.55.250:2380"]}
{"level":"info","ts":"2026-02-02T17:40:54.510971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d is starting a new election at term 1"}
{"level":"info","ts":"2026-02-02T17:40:54.511092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-02T17:40:54.511119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d received MsgPreVoteResp from 1e4a0bccff66c64d at term 1"}
{"level":"info","ts":"2026-02-02T17:40:54.511139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became candidate at term 2"}
{"level":"info","ts":"2026-02-02T17:40:54.511284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d received MsgVoteResp from 1e4a0bccff66c64d at term 2"}
{"level":"info","ts":"2026-02-02T17:40:54.511315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became leader at term 2"}
{"level":"info","ts":"2026-02-02T17:40:54.511335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1e4a0bccff66c64d elected leader 1e4a0bccff66c64d at term 2"}
{"level":"info","ts":"2026-02-02T17:40:54.519093Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1e4a0bccff66c64d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.250:2379]}","request-path":"/0/members/1e4a0bccff66c64d/attributes","cluster-id":"8ba64f6e83da771","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-02T17:40:54.519143Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-02T17:40:54.519452Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-02T17:40:54.522952Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-02T17:40:54.523861Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ba64f6e83da771","local-member-id":"1e4a0bccff66c64d","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-02T17:40:54.524075Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-02T17:40:54.524519Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.250:2379"}
{"level":"info","ts":"2026-02-02T17:40:54.524608Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-02T17:40:54.524642Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-02T17:40:54.524851Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-02T17:40:54.543377Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-02T17:41:07.052419Z","caller":"traceutil/trace.go:171","msg":"trace[1907835311] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"167.131986ms","start":"2026-02-02T17:41:06.885219Z","end":"2026-02-02T17:41:07.052351Z","steps":["trace[1907835311] 'process raft request'  (duration: 167.010495ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:41:07.245184Z","caller":"traceutil/trace.go:171","msg":"trace[1772159602] linearizableReadLoop","detail":"{readStateIndex:372; appliedIndex:371; }","duration":"107.374116ms","start":"2026-02-02T17:41:07.137793Z","end":"2026-02-02T17:41:07.245167Z","steps":["trace[1772159602] 'read index received'  (duration: 107.220705ms)","trace[1772159602] 'applied index is now lower than readState.Index'  (duration: 152.921µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-02T17:41:07.245284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.470146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:41:07.24531Z","caller":"traceutil/trace.go:171","msg":"trace[1264957695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:361; }","duration":"107.521247ms","start":"2026-02-02T17:41:07.137783Z","end":"2026-02-02T17:41:07.245304Z","steps":["trace[1264957695] 'agreement among raft nodes before linearized reading'  (duration: 107.447676ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:41:07.245695Z","caller":"traceutil/trace.go:171","msg":"trace[2122592401] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"358.723019ms","start":"2026-02-02T17:41:06.886965Z","end":"2026-02-02T17:41:07.245688Z","steps":["trace[2122592401] 'process raft request'  (duration: 358.118534ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:41:07.245964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:41:06.886957Z","time spent":"358.759249ms","remote":"127.0.0.1:43842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5083,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:356 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:5035 >> failure:<request_range:<key:\"/registry/pods/kube-system/etcd-instance\" > >"}
{"level":"info","ts":"2026-02-02T17:41:09.630692Z","caller":"traceutil/trace.go:171","msg":"trace[900431481] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"270.285308ms","start":"2026-02-02T17:41:09.36038Z","end":"2026-02-02T17:41:09.630665Z","steps":["trace[900431481] 'process raft request'  (duration: 270.086617ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:41:09.630959Z","caller":"traceutil/trace.go:171","msg":"trace[941730932] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:381; }","duration":"163.419406ms","start":"2026-02-02T17:41:09.467474Z","end":"2026-02-02T17:41:09.630894Z","steps":["trace[941730932] 'read index received'  (duration: 163.409566ms)","trace[941730932] 'applied index is now lower than readState.Index'  (duration: 7.84µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-02T17:41:09.632413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.681438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:41:09.632502Z","caller":"traceutil/trace.go:171","msg":"trace[1962268407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:369; }","duration":"165.035679ms","start":"2026-02-02T17:41:09.467444Z","end":"2026-02-02T17:41:09.63248Z","steps":["trace[1962268407] 'agreement among raft nodes before linearized reading'  (duration: 163.616078ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:41:11.422968Z","caller":"traceutil/trace.go:171","msg":"trace[853359104] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"111.399007ms","start":"2026-02-02T17:41:11.311553Z","end":"2026-02-02T17:41:11.422952Z","steps":["trace[853359104] 'process raft request'  (duration: 69.5071ms)","trace[853359104] 'compare'  (duration: 41.705856ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-02T17:41:31.700181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.786315ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14289248851577594482 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-252tj\" mod_revision:459 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-252tj\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-252tj\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-02T17:41:31.700267Z","caller":"traceutil/trace.go:171","msg":"trace[1995054922] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:527; }","duration":"705.746436ms","start":"2026-02-02T17:41:30.994505Z","end":"2026-02-02T17:41:31.700251Z","steps":["trace[1995054922] 'read index received'  (duration: 269.637789ms)","trace[1995054922] 'applied index is now lower than readState.Index'  (duration: 436.107527ms)"],"step_count":2}
{"level":"info","ts":"2026-02-02T17:41:31.700513Z","caller":"traceutil/trace.go:171","msg":"trace[874130849] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"760.404564ms","start":"2026-02-02T17:41:30.940089Z","end":"2026-02-02T17:41:31.700494Z","steps":["trace[874130849] 'process raft request'  (duration: 324.099355ms)","trace[874130849] 'compare'  (duration: 435.396892ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-02T17:41:31.7006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:41:30.940075Z","time spent":"760.487164ms","remote":"127.0.0.1:43842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-252tj\" mod_revision:459 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-252tj\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-252tj\" > >"}
{"level":"warn","ts":"2026-02-02T17:41:31.700838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.33027ms","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-02-02T17:41:31.700868Z","caller":"traceutil/trace.go:171","msg":"trace[1423458447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:512; }","duration":"706.40998ms","start":"2026-02-02T17:41:30.994449Z","end":"2026-02-02T17:41:31.700859Z","steps":["trace[1423458447] 'agreement among raft nodes before linearized reading'  (duration: 706.302149ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:41:31.700896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:41:30.994431Z","time spent":"706.45879ms","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-02T17:41:31.701067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.423407ms","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-02T17:41:31.701099Z","caller":"traceutil/trace.go:171","msg":"trace[2022254868] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:512; }","duration":"560.492437ms","start":"2026-02-02T17:41:31.140598Z","end":"2026-02-02T17:41:31.70109Z","steps":["trace[2022254868] 'agreement among raft nodes before linearized reading'  (duration: 560.410647ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:41:31.701124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:41:31.140584Z","time spent":"560.533827ms","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-02T17:41:38.127793Z","caller":"traceutil/trace.go:171","msg":"trace[1858966439] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"100.398486ms","start":"2026-02-02T17:41:38.027379Z","end":"2026-02-02T17:41:38.127778Z","steps":["trace[1858966439] 'process raft request'  (duration: 24.319372ms)","trace[1858966439] 'compare'  (duration: 75.900843ms)"],"step_count":2}
{"level":"info","ts":"2026-02-02T17:41:38.128224Z","caller":"traceutil/trace.go:171","msg":"trace[171039917] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"100.632418ms","start":"2026-02-02T17:41:38.027582Z","end":"2026-02-02T17:41:38.128215Z","steps":["trace[171039917] 'process raft request'  (duration: 100.136765ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:41:44.351968Z","caller":"traceutil/trace.go:171","msg":"trace[925461828] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"136.023139ms","start":"2026-02-02T17:41:44.215926Z","end":"2026-02-02T17:41:44.351949Z","steps":["trace[925461828] 'process raft request'  (duration: 132.69206ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:41:44.352456Z","caller":"traceutil/trace.go:171","msg":"trace[401597066] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"136.434071ms","start":"2026-02-02T17:41:44.216016Z","end":"2026-02-02T17:41:44.35245Z","steps":["trace[401597066] 'process raft request'  (duration: 135.887489ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:41:44.352582Z","caller":"traceutil/trace.go:171","msg":"trace[1088824577] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"136.383481ms","start":"2026-02-02T17:41:44.216194Z","end":"2026-02-02T17:41:44.352578Z","steps":["trace[1088824577] 'process raft request'  (duration: 135.736708ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:41:44.477823Z","caller":"traceutil/trace.go:171","msg":"trace[1472942465] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"104.669432ms","start":"2026-02-02T17:41:44.373132Z","end":"2026-02-02T17:41:44.477802Z","steps":["trace[1472942465] 'process raft request'  (duration: 104.628252ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:41:44.478159Z","caller":"traceutil/trace.go:171","msg":"trace[1471239127] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"110.930568ms","start":"2026-02-02T17:41:44.367218Z","end":"2026-02-02T17:41:44.478149Z","steps":["trace[1471239127] 'process raft request'  (duration: 109.245308ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:41:44.478602Z","caller":"traceutil/trace.go:171","msg":"trace[1470121511] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"108.495643ms","start":"2026-02-02T17:41:44.370097Z","end":"2026-02-02T17:41:44.478593Z","steps":["trace[1470121511] 'process raft request'  (duration: 107.548478ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:41:44.478803Z","caller":"traceutil/trace.go:171","msg":"trace[1742323455] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"106.035709ms","start":"2026-02-02T17:41:44.372759Z","end":"2026-02-02T17:41:44.478794Z","steps":["trace[1742323455] 'process raft request'  (duration: 104.943143ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:02.586772Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577594958,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:03.087954Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577594958,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:03.588756Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577594958,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:04.089582Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577594958,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:04.465515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000777091s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-02T17:42:04.465579Z","caller":"traceutil/trace.go:171","msg":"trace[921612887] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000865571s","start":"2026-02-02T17:42:02.464698Z","end":"2026-02-02T17:42:04.465564Z","steps":["trace[921612887] 'agreement among raft nodes before linearized reading'  (duration: 2.000789291s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.465614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:02.46469Z","time spent":"2.000916881s","remote":"127.0.0.1:43682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-02T17:42:04.582109Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.497883229s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-02T17:42:04.582978Z","caller":"traceutil/trace.go:171","msg":"trace[934961557] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"2.498755583s","start":"2026-02-02T17:42:02.084147Z","end":"2026-02-02T17:42:04.582903Z","steps":["trace[934961557] 'process raft request'  (duration: 2.498259921s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.584822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:02.08413Z","time spent":"2.498995324s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:739 > 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-02T17:42:04.775333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.300751ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14289248851577594960 > lease_revoke:<id:464d9c1f7170e3d6>","response":"size:27"}
{"level":"info","ts":"2026-02-02T17:42:04.775424Z","caller":"traceutil/trace.go:171","msg":"trace[2079047377] linearizableReadLoop","detail":"{readStateIndex:771; appliedIndex:769; }","duration":"2.68931977s","start":"2026-02-02T17:42:02.086089Z","end":"2026-02-02T17:42:04.775409Z","steps":["trace[2079047377] 'read index received'  (duration: 2.496310392s)","trace[2079047377] 'applied index is now lower than readState.Index'  (duration: 193.008008ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-02T17:42:04.775569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.68948004s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-02T17:42:04.775601Z","caller":"traceutil/trace.go:171","msg":"trace[1519342232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:746; }","duration":"2.68953707s","start":"2026-02-02T17:42:02.086045Z","end":"2026-02-02T17:42:04.775582Z","steps":["trace[1519342232] 'agreement among raft nodes before linearized reading'  (duration: 2.68943339s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.775571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.687353419s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-02-02T17:42:04.77562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:02.086026Z","time spent":"2.689590321s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-02T17:42:04.775626Z","caller":"traceutil/trace.go:171","msg":"trace[1685375926] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:746; }","duration":"2.68742168s","start":"2026-02-02T17:42:02.088194Z","end":"2026-02-02T17:42:04.775616Z","steps":["trace[1685375926] 'agreement among raft nodes before linearized reading'  (duration: 2.687299459s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.775685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:02.088186Z","time spent":"2.68749144s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-02T17:42:04.775778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.886409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:42:04.775801Z","caller":"traceutil/trace.go:171","msg":"trace[1211389533] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:746; }","duration":"309.907609ms","start":"2026-02-02T17:42:04.465886Z","end":"2026-02-02T17:42:04.775794Z","steps":["trace[1211389533] 'agreement among raft nodes before linearized reading'  (duration: 309.871239ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.775824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:04.465876Z","time spent":"309.94379ms","remote":"127.0.0.1:43684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-02T17:42:04.775906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078279966s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:42:04.775922Z","caller":"traceutil/trace.go:171","msg":"trace[2036721617] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:746; }","duration":"1.078325556s","start":"2026-02-02T17:42:03.697592Z","end":"2026-02-02T17:42:04.775917Z","steps":["trace[2036721617] 'agreement among raft nodes before linearized reading'  (duration: 1.078285106s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.775936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:03.697581Z","time spent":"1.078351096s","remote":"127.0.0.1:54800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 "}
{"level":"warn","ts":"2026-02-02T17:42:04.775968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078356606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:42:04.775998Z","caller":"traceutil/trace.go:171","msg":"trace[793978677] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:746; }","duration":"1.078392876s","start":"2026-02-02T17:42:03.697594Z","end":"2026-02-02T17:42:04.775987Z","steps":["trace[793978677] 'agreement among raft nodes before linearized reading'  (duration: 1.078351596s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.776024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.367799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-02T17:42:04.776026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:03.69759Z","time spent":"1.078427936s","remote":"127.0.0.1:54800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "}
{"level":"info","ts":"2026-02-02T17:42:04.77604Z","caller":"traceutil/trace.go:171","msg":"trace[99770275] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:746; }","duration":"551.39211ms","start":"2026-02-02T17:42:04.224643Z","end":"2026-02-02T17:42:04.776035Z","steps":["trace[99770275] 'agreement among raft nodes before linearized reading'  (duration: 551.368209ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.776067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:04.224639Z","time spent":"551.42342ms","remote":"127.0.0.1:54812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-02T17:42:04.776142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078603208s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-02T17:42:04.776153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.51388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:42:04.776167Z","caller":"traceutil/trace.go:171","msg":"trace[964019722] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:746; }","duration":"551.53835ms","start":"2026-02-02T17:42:04.224624Z","end":"2026-02-02T17:42:04.776162Z","steps":["trace[964019722] 'agreement among raft nodes before linearized reading'  (duration: 551.517ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:04.776167Z","caller":"traceutil/trace.go:171","msg":"trace[444667234] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:746; }","duration":"1.078638708s","start":"2026-02-02T17:42:03.69752Z","end":"2026-02-02T17:42:04.776159Z","steps":["trace[444667234] 'agreement among raft nodes before linearized reading'  (duration: 1.078598048s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.776181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:04.224618Z","time spent":"551.55962ms","remote":"127.0.0.1:54812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "}
{"level":"warn","ts":"2026-02-02T17:42:04.776193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:03.697515Z","time spent":"1.078670938s","remote":"127.0.0.1:54800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 "}
{"level":"warn","ts":"2026-02-02T17:42:04.77625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.653282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:42:04.776263Z","caller":"traceutil/trace.go:171","msg":"trace[688105826] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:746; }","duration":"551.746732ms","start":"2026-02-02T17:42:04.224513Z","end":"2026-02-02T17:42:04.776259Z","steps":["trace[688105826] 'agreement among raft nodes before linearized reading'  (duration: 551.726822ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.776275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:04.224494Z","time spent":"551.777882ms","remote":"127.0.0.1:54812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "}
{"level":"warn","ts":"2026-02-02T17:42:04.776304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081030561s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:42:04.776329Z","caller":"traceutil/trace.go:171","msg":"trace[1603991557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:746; }","duration":"1.081082061s","start":"2026-02-02T17:42:03.695239Z","end":"2026-02-02T17:42:04.776321Z","steps":["trace[1603991557] 'agreement among raft nodes before linearized reading'  (duration: 1.081046261s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.776345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.750102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-02T17:42:04.776351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:03.695224Z","time spent":"1.081121911s","remote":"127.0.0.1:43682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-02T17:42:04.776371Z","caller":"traceutil/trace.go:171","msg":"trace[490111057] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:746; }","duration":"710.788602ms","start":"2026-02-02T17:42:04.065565Z","end":"2026-02-02T17:42:04.776353Z","steps":["trace[490111057] 'agreement among raft nodes before linearized reading'  (duration: 710.768922ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.776384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:04.06555Z","time spent":"710.830942ms","remote":"127.0.0.1:43898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-02-02T17:42:04.776503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.495398861s","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-02T17:42:04.776527Z","caller":"traceutil/trace.go:171","msg":"trace[63466327] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:746; }","duration":"1.495459391s","start":"2026-02-02T17:42:03.281059Z","end":"2026-02-02T17:42:04.776519Z","steps":["trace[63466327] 'agreement among raft nodes before linearized reading'  (duration: 1.49538836s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.77655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:03.281045Z","time spent":"1.495500121s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-02T17:42:04.77671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.459854703s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-02T17:42:04.776739Z","caller":"traceutil/trace.go:171","msg":"trace[245537432] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:746; }","duration":"2.459909963s","start":"2026-02-02T17:42:02.316821Z","end":"2026-02-02T17:42:04.77673Z","steps":["trace[245537432] 'agreement among raft nodes before linearized reading'  (duration: 2.459834452s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:04.776763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:02.316806Z","time spent":"2.459951183s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-02T17:42:04.994433Z","caller":"traceutil/trace.go:171","msg":"trace[1015378928] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"202.555848ms","start":"2026-02-02T17:42:04.791861Z","end":"2026-02-02T17:42:04.994416Z","steps":["trace[1015378928] 'process raft request'  (duration: 202.403377ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:04.994591Z","caller":"traceutil/trace.go:171","msg":"trace[1917743444] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"202.677729ms","start":"2026-02-02T17:42:04.791909Z","end":"2026-02-02T17:42:04.994587Z","steps":["trace[1917743444] 'process raft request'  (duration: 202.479638ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:04.994699Z","caller":"traceutil/trace.go:171","msg":"trace[1512655894] linearizableReadLoop","detail":"{readStateIndex:774; appliedIndex:771; }","duration":"201.661883ms","start":"2026-02-02T17:42:04.793032Z","end":"2026-02-02T17:42:04.994694Z","steps":["trace[1512655894] 'read index received'  (duration: 63.407871ms)","trace[1512655894] 'applied index is now lower than readState.Index'  (duration: 138.253472ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-02T17:42:04.994774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.718183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:42:04.994789Z","caller":"traceutil/trace.go:171","msg":"trace[847110867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:750; }","duration":"201.769394ms","start":"2026-02-02T17:42:04.793015Z","end":"2026-02-02T17:42:04.994784Z","steps":["trace[847110867] 'agreement among raft nodes before linearized reading'  (duration: 201.696363ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:04.994884Z","caller":"traceutil/trace.go:171","msg":"trace[803375318] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"200.140135ms","start":"2026-02-02T17:42:04.794739Z","end":"2026-02-02T17:42:04.994879Z","steps":["trace[803375318] 'process raft request'  (duration: 199.829304ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:04.994943Z","caller":"traceutil/trace.go:171","msg":"trace[1732438469] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"200.167135ms","start":"2026-02-02T17:42:04.794772Z","end":"2026-02-02T17:42:04.994939Z","steps":["trace[1732438469] 'process raft request'  (duration: 199.890704ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:05.396625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.2781ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14289248851577594969 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18907ed92d0e6b2a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18907ed92d0e6b2a\" value_size:672 lease:5065876814722819155 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-02T17:42:05.396731Z","caller":"traceutil/trace.go:171","msg":"trace[1602018871] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"539.4096ms","start":"2026-02-02T17:42:04.857304Z","end":"2026-02-02T17:42:05.396713Z","steps":["trace[1602018871] 'process raft request'  (duration: 321.973429ms)","trace[1602018871] 'compare'  (duration: 216.779578ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-02T17:42:05.396783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:04.857281Z","time spent":"539.48107ms","remote":"127.0.0.1:43756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18907ed92d0e6b2a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18907ed92d0e6b2a\" value_size:672 lease:5065876814722819155 >> failure:<>"}
{"level":"warn","ts":"2026-02-02T17:42:08.016627Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577594982,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:08.517048Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577594982,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:09.017961Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577594982,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:09.513652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.09966ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:42:09.513726Z","caller":"traceutil/trace.go:171","msg":"trace[978540475] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:753; }","duration":"194.18595ms","start":"2026-02-02T17:42:09.319529Z","end":"2026-02-02T17:42:09.513715Z","steps":["trace[978540475] 'range keys from in-memory index tree'  (duration: 194.08884ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:09.515299Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.455964211s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-02T17:42:09.515667Z","caller":"traceutil/trace.go:171","msg":"trace[1988808380] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"2.50218686s","start":"2026-02-02T17:42:07.013463Z","end":"2026-02-02T17:42:09.51565Z","steps":["trace[1988808380] 'process raft request'  (duration: 2.50214314s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:09.515758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:07.013454Z","time spent":"2.502245831s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:747 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-02T17:42:09.515985Z","caller":"traceutil/trace.go:171","msg":"trace[1133135749] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"2.504301361s","start":"2026-02-02T17:42:07.011675Z","end":"2026-02-02T17:42:09.515976Z","steps":["trace[1133135749] 'process raft request'  (duration: 2.503827099s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:09.516066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:07.011666Z","time spent":"2.504361451s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:749 > 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-02T17:42:09.5258Z","caller":"traceutil/trace.go:171","msg":"trace[611242281] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"2.462200752s","start":"2026-02-02T17:42:07.063587Z","end":"2026-02-02T17:42:09.525788Z","steps":["trace[611242281] 'process raft request'  (duration: 2.462130052s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:09.525872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:07.063573Z","time spent":"2.462261413s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:750 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-02T17:42:09.525963Z","caller":"traceutil/trace.go:171","msg":"trace[1259247503] linearizableReadLoop","detail":"{readStateIndex:783; appliedIndex:781; }","duration":"2.009357187s","start":"2026-02-02T17:42:07.51659Z","end":"2026-02-02T17:42:09.525947Z","steps":["trace[1259247503] 'read index received'  (duration: 1.999373146s)","trace[1259247503] 'applied index is now lower than readState.Index'  (duration: 9.983121ms)"],"step_count":2}
{"level":"info","ts":"2026-02-02T17:42:09.526089Z","caller":"traceutil/trace.go:171","msg":"trace[1982262480] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"1.740354614s","start":"2026-02-02T17:42:07.785678Z","end":"2026-02-02T17:42:09.526032Z","steps":["trace[1982262480] 'process raft request'  (duration: 1.740082563s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:09.526168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:07.785654Z","time spent":"1.740452635s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:732 > 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-02-02T17:42:09.52618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.587203051s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.250\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-02T17:42:09.526201Z","caller":"traceutil/trace.go:171","msg":"trace[1870443245] range","detail":"{range_begin:/registry/masterleases/162.253.55.250; range_end:; response_count:1; response_revision:757; }","duration":"1.587249851s","start":"2026-02-02T17:42:07.938945Z","end":"2026-02-02T17:42:09.526195Z","steps":["trace[1870443245] 'agreement among raft nodes before linearized reading'  (duration: 1.587178131s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:09.526251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:07.938908Z","time spent":"1.587338101s","remote":"127.0.0.1:43706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.250\" "}
{"level":"warn","ts":"2026-02-02T17:42:09.52635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.009766089s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-02T17:42:09.526364Z","caller":"traceutil/trace.go:171","msg":"trace[528237503] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:757; }","duration":"2.009817289s","start":"2026-02-02T17:42:07.516542Z","end":"2026-02-02T17:42:09.526359Z","steps":["trace[528237503] 'agreement among raft nodes before linearized reading'  (duration: 2.009789579s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:09.526379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:07.516523Z","time spent":"2.00985258s","remote":"127.0.0.1:43854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":29,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"warn","ts":"2026-02-02T17:42:09.526384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063528715s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:42:09.526408Z","caller":"traceutil/trace.go:171","msg":"trace[1349165512] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:757; }","duration":"1.063579125s","start":"2026-02-02T17:42:08.462822Z","end":"2026-02-02T17:42:09.526401Z","steps":["trace[1349165512] 'agreement among raft nodes before linearized reading'  (duration: 1.063536355s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:09.526426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:08.462802Z","time spent":"1.063621175s","remote":"127.0.0.1:43682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-02T17:42:09.526456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.364029378s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-02T17:42:09.526469Z","caller":"traceutil/trace.go:171","msg":"trace[1013364099] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:757; }","duration":"1.364066528s","start":"2026-02-02T17:42:08.162399Z","end":"2026-02-02T17:42:09.526465Z","steps":["trace[1013364099] 'agreement among raft nodes before linearized reading'  (duration: 1.364037118s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:09.526481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:08.162384Z","time spent":"1.364093418s","remote":"127.0.0.1:43996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":13,"response size":29,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "}
{"level":"warn","ts":"2026-02-02T17:42:09.526585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.181517ms","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-02T17:42:09.526604Z","caller":"traceutil/trace.go:171","msg":"trace[657907652] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:757; }","duration":"463.231667ms","start":"2026-02-02T17:42:09.063365Z","end":"2026-02-02T17:42:09.526597Z","steps":["trace[657907652] 'agreement among raft nodes before linearized reading'  (duration: 463.151217ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:09.526619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:09.063352Z","time spent":"463.262997ms","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-02T17:42:09.526733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.696684ms","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-02-02T17:42:09.526748Z","caller":"traceutil/trace.go:171","msg":"trace[15644269] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:757; }","duration":"919.736594ms","start":"2026-02-02T17:42:08.607007Z","end":"2026-02-02T17:42:09.526744Z","steps":["trace[15644269] 'agreement among raft nodes before linearized reading'  (duration: 919.692563ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:09.526762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:08.606994Z","time spent":"919.763324ms","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-02T17:42:11.436008Z","caller":"traceutil/trace.go:171","msg":"trace[1019792576] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"119.409302ms","start":"2026-02-02T17:42:11.31658Z","end":"2026-02-02T17:42:11.435989Z","steps":["trace[1019792576] 'process raft request'  (duration: 119.274451ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:13.732449Z","caller":"traceutil/trace.go:171","msg":"trace[1712905661] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"111.61059ms","start":"2026-02-02T17:42:13.620822Z","end":"2026-02-02T17:42:13.732433Z","steps":["trace[1712905661] 'process raft request'  (duration: 111.462409ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:16.005216Z","caller":"traceutil/trace.go:171","msg":"trace[1942452349] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:800; }","duration":"178.141854ms","start":"2026-02-02T17:42:15.82706Z","end":"2026-02-02T17:42:16.005202Z","steps":["trace[1942452349] 'read index received'  (duration: 118.607422ms)","trace[1942452349] 'applied index is now lower than readState.Index'  (duration: 59.533622ms)"],"step_count":2}
{"level":"info","ts":"2026-02-02T17:42:16.005424Z","caller":"traceutil/trace.go:171","msg":"trace[2111186740] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"179.966284ms","start":"2026-02-02T17:42:15.825449Z","end":"2026-02-02T17:42:16.005415Z","steps":["trace[2111186740] 'process raft request'  (duration: 120.209941ms)","trace[2111186740] 'compare'  (duration: 59.351981ms)"],"step_count":2}
{"level":"info","ts":"2026-02-02T17:42:16.00552Z","caller":"traceutil/trace.go:171","msg":"trace[1485242909] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"178.497456ms","start":"2026-02-02T17:42:15.827018Z","end":"2026-02-02T17:42:16.005516Z","steps":["trace[1485242909] 'process raft request'  (duration: 178.162755ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:16.005631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.557286ms","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-02-02T17:42:16.005647Z","caller":"traceutil/trace.go:171","msg":"trace[1461498937] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:774; }","duration":"178.594946ms","start":"2026-02-02T17:42:15.827047Z","end":"2026-02-02T17:42:16.005642Z","steps":["trace[1461498937] 'agreement among raft nodes before linearized reading'  (duration: 178.521046ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:16.005726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.984073ms","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-02T17:42:16.00574Z","caller":"traceutil/trace.go:171","msg":"trace[436672978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:774; }","duration":"178.008014ms","start":"2026-02-02T17:42:15.827727Z","end":"2026-02-02T17:42:16.005735Z","steps":["trace[436672978] 'agreement among raft nodes before linearized reading'  (duration: 177.973743ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:18.237737Z","caller":"traceutil/trace.go:171","msg":"trace[1964320919] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"214.382112ms","start":"2026-02-02T17:42:18.023325Z","end":"2026-02-02T17:42:18.237707Z","steps":["trace[1964320919] 'process raft request'  (duration: 214.194321ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:18.281051Z","caller":"traceutil/trace.go:171","msg":"trace[351209546] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"235.241158ms","start":"2026-02-02T17:42:18.045793Z","end":"2026-02-02T17:42:18.281034Z","steps":["trace[351209546] 'read index received'  (duration: 193.006564ms)","trace[351209546] 'applied index is now lower than readState.Index'  (duration: 42.233814ms)"],"step_count":2}
{"level":"info","ts":"2026-02-02T17:42:18.28126Z","caller":"traceutil/trace.go:171","msg":"trace[1040369833] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"256.593066ms","start":"2026-02-02T17:42:18.024659Z","end":"2026-02-02T17:42:18.281252Z","steps":["trace[1040369833] 'process raft request'  (duration: 256.279494ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:18.281446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.642929ms","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-02T17:42:18.281468Z","caller":"traceutil/trace.go:171","msg":"trace[1776669509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:780; }","duration":"235.70127ms","start":"2026-02-02T17:42:18.04576Z","end":"2026-02-02T17:42:18.281462Z","steps":["trace[1776669509] 'agreement among raft nodes before linearized reading'  (duration: 235.608119ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:18.28159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.797659ms","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-02-02T17:42:18.281607Z","caller":"traceutil/trace.go:171","msg":"trace[871182018] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:780; }","duration":"215.834779ms","start":"2026-02-02T17:42:18.065767Z","end":"2026-02-02T17:42:18.281602Z","steps":["trace[871182018] 'agreement among raft nodes before linearized reading'  (duration: 215.786219ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:20.353418Z","caller":"traceutil/trace.go:171","msg":"trace[1773776308] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"108.549826ms","start":"2026-02-02T17:42:20.244855Z","end":"2026-02-02T17:42:20.353404Z","steps":["trace[1773776308] 'process raft request'  (duration: 108.161564ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:27.005884Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:27.506451Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:28.006612Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:28.506879Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:29.007263Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:29.46529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000294312s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-02T17:42:29.465366Z","caller":"traceutil/trace.go:171","msg":"trace[1964780427] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000410682s","start":"2026-02-02T17:42:27.464936Z","end":"2026-02-02T17:42:29.465347Z","steps":["trace[1964780427] 'agreement among raft nodes before linearized reading'  (duration: 2.000316372s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:29.465813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:27.464906Z","time spent":"2.000688203s","remote":"127.0.0.1:43682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/02 17:42:29 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-02T17:42:29.508097Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:30.009157Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:30.509426Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:31.01035Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:31.466452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000652566s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-02T17:42:31.466658Z","caller":"traceutil/trace.go:171","msg":"trace[698457851] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000924898s","start":"2026-02-02T17:42:29.465697Z","end":"2026-02-02T17:42:31.466622Z","steps":["trace[698457851] 'agreement among raft nodes before linearized reading'  (duration: 2.000679896s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:31.466757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:29.46565Z","time spent":"2.001087809s","remote":"127.0.0.1:43684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-02T17:42:31.474577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:26.477327Z","time spent":"4.997238734s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/02/02 17:42:31 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-02T17:42:31.512822Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:32.012993Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:32.081883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.001498591s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-02T17:42:32.082114Z","caller":"traceutil/trace.go:171","msg":"trace[296614777] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001783703s","start":"2026-02-02T17:42:30.080315Z","end":"2026-02-02T17:42:32.082099Z","steps":["trace[296614777] 'agreement among raft nodes before linearized reading'  (duration: 2.001529822s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:32.082256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:30.080294Z","time spent":"2.001951783s","remote":"127.0.0.1:43682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-02T17:42:32.514232Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:32.869206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999349666s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-02T17:42:32.869269Z","caller":"traceutil/trace.go:171","msg":"trace[1590978242] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999461418s","start":"2026-02-02T17:42:27.869795Z","end":"2026-02-02T17:42:32.869257Z","steps":["trace[1590978242] 'agreement among raft nodes before linearized reading'  (duration: 4.999380437s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:32.869298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:27.869778Z","time spent":"4.999514928s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/02/02 17:42:32 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-02T17:42:33.014889Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289248851577595117,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-02T17:42:33.024046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.704438506s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:42:33.024127Z","caller":"traceutil/trace.go:171","msg":"trace[390428226] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:801; }","duration":"3.704528496s","start":"2026-02-02T17:42:29.319587Z","end":"2026-02-02T17:42:33.024116Z","steps":["trace[390428226] 'range keys from in-memory index tree'  (duration: 3.704425876s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:33.034143Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"6.556751469s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-02T17:42:33.2305Z","caller":"traceutil/trace.go:171","msg":"trace[1811530565] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"6.753079847s","start":"2026-02-02T17:42:26.477395Z","end":"2026-02-02T17:42:33.230475Z","steps":["trace[1811530565] 'process raft request'  (duration: 6.659885248s)","trace[1811530565] 'compare'  (duration: 92.321305ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-02T17:42:33.23068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:26.47738Z","time spent":"6.753191668s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:798 > 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-02T17:42:33.230827Z","caller":"traceutil/trace.go:171","msg":"trace[2076941126] linearizableReadLoop","detail":"{readStateIndex:835; appliedIndex:832; }","duration":"6.725768312s","start":"2026-02-02T17:42:26.505037Z","end":"2026-02-02T17:42:33.230805Z","steps":["trace[2076941126] 'read index received'  (duration: 6.529397883s)","trace[2076941126] 'applied index is now lower than readState.Index'  (duration: 196.369129ms)"],"step_count":2}
{"level":"info","ts":"2026-02-02T17:42:33.231354Z","caller":"traceutil/trace.go:171","msg":"trace[889074308] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"3.030641011s","start":"2026-02-02T17:42:30.200699Z","end":"2026-02-02T17:42:33.23134Z","steps":["trace[889074308] 'process raft request'  (duration: 3.029812446s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:33.231608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:30.200683Z","time spent":"3.030808552s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:784 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-02T17:42:33.231898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.698408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4912"}
{"level":"info","ts":"2026-02-02T17:42:33.232326Z","caller":"traceutil/trace.go:171","msg":"trace[1641082653] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:805; }","duration":"164.12189ms","start":"2026-02-02T17:42:33.06819Z","end":"2026-02-02T17:42:33.232312Z","steps":["trace[1641082653] 'agreement among raft nodes before linearized reading'  (duration: 163.626917ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:33.231894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.726859488s","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-02T17:42:33.23256Z","caller":"traceutil/trace.go:171","msg":"trace[223945675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:805; }","duration":"6.727550811s","start":"2026-02-02T17:42:26.504995Z","end":"2026-02-02T17:42:33.232546Z","steps":["trace[223945675] 'agreement among raft nodes before linearized reading'  (duration: 6.726782077s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:33.232627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:26.504959Z","time spent":"6.727654682s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-02T17:42:33.231969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.291669927s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.250\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-02T17:42:33.232731Z","caller":"traceutil/trace.go:171","msg":"trace[1910524651] range","detail":"{range_begin:/registry/masterleases/162.253.55.250; range_end:; response_count:1; response_revision:805; }","duration":"5.29245054s","start":"2026-02-02T17:42:27.94027Z","end":"2026-02-02T17:42:33.232721Z","steps":["trace[1910524651] 'agreement among raft nodes before linearized reading'  (duration: 5.291515936s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:33.232765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:27.940259Z","time spent":"5.292497641s","remote":"127.0.0.1:43706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.250\" "}
{"level":"info","ts":"2026-02-02T17:42:33.232008Z","caller":"traceutil/trace.go:171","msg":"trace[945395053] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"1.364894809s","start":"2026-02-02T17:42:31.867099Z","end":"2026-02-02T17:42:33.231994Z","steps":["trace[945395053] 'process raft request'  (duration: 1.363654093s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:33.232968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:31.867083Z","time spent":"1.365836523s","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:789 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-02T17:42:33.232062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.758961438s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:42:33.233118Z","caller":"traceutil/trace.go:171","msg":"trace[305469721] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:805; }","duration":"1.760040033s","start":"2026-02-02T17:42:31.473067Z","end":"2026-02-02T17:42:33.233107Z","steps":["trace[305469721] 'agreement among raft nodes before linearized reading'  (duration: 1.758976188s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:33.233158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:31.473053Z","time spent":"1.760094413s","remote":"127.0.0.1:43682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-02T17:42:33.232133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.757837063s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18907ed92d0e6b2a\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-02T17:42:33.233314Z","caller":"traceutil/trace.go:171","msg":"trace[927717656] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18907ed92d0e6b2a; range_end:; response_count:1; response_revision:805; }","duration":"1.759058118s","start":"2026-02-02T17:42:31.474245Z","end":"2026-02-02T17:42:33.233303Z","steps":["trace[927717656] 'agreement among raft nodes before linearized reading'  (duration: 1.757833093s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:33.233356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:31.474218Z","time spent":"1.759126249s","remote":"127.0.0.1:43756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":796,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18907ed92d0e6b2a\" "}
{"level":"warn","ts":"2026-02-02T17:42:33.232204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.065919786s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-02T17:42:33.233676Z","caller":"traceutil/trace.go:171","msg":"trace[1235047108] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:805; }","duration":"2.067446313s","start":"2026-02-02T17:42:31.166216Z","end":"2026-02-02T17:42:33.233662Z","steps":["trace[1235047108] 'agreement among raft nodes before linearized reading'  (duration: 2.065945676s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:33.23228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.75674551s","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-02-02T17:42:33.238418Z","caller":"traceutil/trace.go:171","msg":"trace[2130740784] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:805; }","duration":"4.762914462s","start":"2026-02-02T17:42:28.475491Z","end":"2026-02-02T17:42:33.238406Z","steps":["trace[2130740784] 'agreement among raft nodes before linearized reading'  (duration: 4.756741491s)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:33.23848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:28.475471Z","time spent":"4.762997302s","remote":"127.0.0.1:43932","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-02T17:42:33.238642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:42:31.166194Z","time spent":"2.072437128s","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":42,"response size":29,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "}
{"level":"info","ts":"2026-02-02T17:42:33.407443Z","caller":"traceutil/trace.go:171","msg":"trace[1998420757] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"166.073509ms","start":"2026-02-02T17:42:33.241335Z","end":"2026-02-02T17:42:33.407408Z","steps":["trace[1998420757] 'process raft request'  (duration: 165.888488ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:33.407718Z","caller":"traceutil/trace.go:171","msg":"trace[1162315564] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"168.530951ms","start":"2026-02-02T17:42:33.239174Z","end":"2026-02-02T17:42:33.407705Z","steps":["trace[1162315564] 'process raft request'  (duration: 94.902838ms)","trace[1162315564] 'compare'  (duration: 73.045661ms)"],"step_count":2}
{"level":"info","ts":"2026-02-02T17:42:33.40816Z","caller":"traceutil/trace.go:171","msg":"trace[873699778] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"164.923893ms","start":"2026-02-02T17:42:33.243222Z","end":"2026-02-02T17:42:33.408146Z","steps":["trace[873699778] 'process raft request'  (duration: 164.026868ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:33.408391Z","caller":"traceutil/trace.go:171","msg":"trace[2050281780] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"153.546727ms","start":"2026-02-02T17:42:33.254831Z","end":"2026-02-02T17:42:33.408378Z","steps":["trace[2050281780] 'process raft request'  (duration: 152.437021ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:33.457946Z","caller":"traceutil/trace.go:171","msg":"trace[2091813017] linearizableReadLoop","detail":"{readStateIndex:840; appliedIndex:836; }","duration":"194.77973ms","start":"2026-02-02T17:42:33.263151Z","end":"2026-02-02T17:42:33.45793Z","steps":["trace[2091813017] 'read index received'  (duration: 70.932529ms)","trace[2091813017] 'applied index is now lower than readState.Index'  (duration: 123.846361ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-02T17:42:33.458039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.87709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-02T17:42:33.458054Z","caller":"traceutil/trace.go:171","msg":"trace[1994638488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"194.928361ms","start":"2026-02-02T17:42:33.263121Z","end":"2026-02-02T17:42:33.458049Z","steps":["trace[1994638488] 'agreement among raft nodes before linearized reading'  (duration: 194.89108ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:35.527458Z","caller":"traceutil/trace.go:171","msg":"trace[1317845352] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"106.842375ms","start":"2026-02-02T17:42:35.420595Z","end":"2026-02-02T17:42:35.527437Z","steps":["trace[1317845352] 'process raft request'  (duration: 106.452924ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:37.708452Z","caller":"traceutil/trace.go:171","msg":"trace[435333924] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"141.488055ms","start":"2026-02-02T17:42:37.566939Z","end":"2026-02-02T17:42:37.708427Z","steps":["trace[435333924] 'process raft request'  (duration: 141.440715ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:37.70893Z","caller":"traceutil/trace.go:171","msg":"trace[1153372189] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"145.447014ms","start":"2026-02-02T17:42:37.563466Z","end":"2026-02-02T17:42:37.708913Z","steps":["trace[1153372189] 'process raft request'  (duration: 109.887069ms)","trace[1153372189] 'compare'  (duration: 34.883832ms)"],"step_count":2}
{"level":"info","ts":"2026-02-02T17:42:39.821024Z","caller":"traceutil/trace.go:171","msg":"trace[14391544] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"106.234651ms","start":"2026-02-02T17:42:39.714764Z","end":"2026-02-02T17:42:39.820999Z","steps":["trace[14391544] 'process raft request'  (duration: 106.1096ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:39.834035Z","caller":"traceutil/trace.go:171","msg":"trace[495203836] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"117.578296ms","start":"2026-02-02T17:42:39.716445Z","end":"2026-02-02T17:42:39.834023Z","steps":["trace[495203836] 'process raft request'  (duration: 117.466084ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:42.089294Z","caller":"traceutil/trace.go:171","msg":"trace[884234275] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"231.953614ms","start":"2026-02-02T17:42:41.857317Z","end":"2026-02-02T17:42:42.089271Z","steps":["trace[884234275] 'process raft request'  (duration: 231.809613ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:43.853346Z","caller":"traceutil/trace.go:171","msg":"trace[1612029349] linearizableReadLoop","detail":"{readStateIndex:870; appliedIndex:869; }","duration":"125.802954ms","start":"2026-02-02T17:42:43.727524Z","end":"2026-02-02T17:42:43.853327Z","steps":["trace[1612029349] 'read index received'  (duration: 7.548427ms)","trace[1612029349] 'applied index is now lower than readState.Index'  (duration: 118.253567ms)"],"step_count":2}
{"level":"info","ts":"2026-02-02T17:42:43.85387Z","caller":"traceutil/trace.go:171","msg":"trace[2084665559] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"170.018338ms","start":"2026-02-02T17:42:43.683826Z","end":"2026-02-02T17:42:43.853844Z","steps":["trace[2084665559] 'process raft request'  (duration: 169.407826ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-02T17:42:43.853904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.357888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329936"}
{"level":"info","ts":"2026-02-02T17:42:43.854449Z","caller":"traceutil/trace.go:171","msg":"trace[215174177] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:837; }","duration":"126.91028ms","start":"2026-02-02T17:42:43.72752Z","end":"2026-02-02T17:42:43.85443Z","steps":["trace[215174177] 'agreement among raft nodes before linearized reading'  (duration: 125.885644ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:45.254251Z","caller":"traceutil/trace.go:171","msg":"trace[1381324908] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"134.783086ms","start":"2026-02-02T17:42:45.119452Z","end":"2026-02-02T17:42:45.254235Z","steps":["trace[1381324908] 'process raft request'  (duration: 134.681646ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:46.097915Z","caller":"traceutil/trace.go:171","msg":"trace[1497792246] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"184.091776ms","start":"2026-02-02T17:42:45.913807Z","end":"2026-02-02T17:42:46.097899Z","steps":["trace[1497792246] 'process raft request'  (duration: 170.327119ms)","trace[1497792246] 'compare'  (duration: 13.526935ms)"],"step_count":2}
{"level":"info","ts":"2026-02-02T17:42:50.418428Z","caller":"traceutil/trace.go:171","msg":"trace[340125956] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"101.679863ms","start":"2026-02-02T17:42:50.31673Z","end":"2026-02-02T17:42:50.41841Z","steps":["trace[340125956] 'process raft request'  (duration: 101.565612ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:53.529648Z","caller":"traceutil/trace.go:171","msg":"trace[1282240527] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"117.962342ms","start":"2026-02-02T17:42:53.411667Z","end":"2026-02-02T17:42:53.529629Z","steps":["trace[1282240527] 'process raft request'  (duration: 117.456779ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:54.121061Z","caller":"traceutil/trace.go:171","msg":"trace[793526154] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"133.524576ms","start":"2026-02-02T17:42:53.987517Z","end":"2026-02-02T17:42:54.121041Z","steps":["trace[793526154] 'process raft request'  (duration: 133.013113ms)"],"step_count":1}
{"level":"info","ts":"2026-02-02T17:42:56.329619Z","caller":"traceutil/trace.go:171","msg":"trace[1038448826] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"119.325157ms","start":"2026-02-02T17:42:56.210263Z","end":"2026-02-02T17:42:56.329588Z","steps":["trace[1038448826] 'process raft request'  (duration: 32.387897ms)","trace[1038448826] 'compare'  (duration: 86.232737ms)"],"step_count":2}
{"level":"info","ts":"2026-02-02T17:43:00.995691Z","caller":"traceutil/trace.go:171","msg":"trace[1832243550] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"218.074382ms","start":"2026-02-02T17:43:00.777597Z","end":"2026-02-02T17:43:00.995671Z","steps":["trace[1832243550] 'process raft request'  (duration: 217.943201ms)"],"step_count":1}