{"level":"warn","ts":"2026-05-04T18:50:30.080994Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-04T18:50:30.081113Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.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://199.204.45.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.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-05-04T18:50:30.08119Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-04T18:50:30.081202Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]}
{"level":"info","ts":"2026-05-04T18:50:30.081225Z","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-05-04T18:50:30.081897Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]}
{"level":"info","ts":"2026-05-04T18:50:30.081989Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.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-05-04T18:50:30.086363Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.148832ms"}
{"level":"info","ts":"2026-05-04T18:50:30.094217Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"}
{"level":"info","ts":"2026-05-04T18:50:30.094316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"}
{"level":"info","ts":"2026-05-04T18:50:30.094348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"}
{"level":"info","ts":"2026-05-04T18:50:30.094374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-04T18:50:30.094392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"}
{"level":"info","ts":"2026-05-04T18:50:30.094449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"}
{"level":"warn","ts":"2026-05-04T18:50:30.100168Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-04T18:50:30.102918Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-04T18:50:30.10409Z","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-05-04T18:50:30.106478Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-04T18:50:30.106609Z","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-05-04T18:50:30.106755Z","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-05-04T18:50:30.106788Z","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-05-04T18:50:30.106846Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-04T18:50:30.109683Z","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-05-04T18:50:30.10986Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-04T18:50:30.109895Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-04T18:50:30.110034Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"}
{"level":"info","ts":"2026-05-04T18:50:30.110049Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"}
{"level":"info","ts":"2026-05-04T18:50:30.110386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"}
{"level":"info","ts":"2026-05-04T18:50:30.112754Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]}
{"level":"info","ts":"2026-05-04T18:50:31.09477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"}
{"level":"info","ts":"2026-05-04T18:50:31.094863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-04T18:50:31.094893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"}
{"level":"info","ts":"2026-05-04T18:50:31.094912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"}
{"level":"info","ts":"2026-05-04T18:50:31.094918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"}
{"level":"info","ts":"2026-05-04T18:50:31.094928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"}
{"level":"info","ts":"2026-05-04T18:50:31.094937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"}
{"level":"info","ts":"2026-05-04T18:50:31.095823Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-04T18:50:31.095899Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-04T18:50:31.095995Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T18:50:31.096036Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-04T18:50:31.096149Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-04T18:50:31.096236Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-04T18:50:31.096664Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T18:50:31.096737Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T18:50:31.096755Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T18:50:31.09879Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-04T18:50:31.099137Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"}
{"level":"info","ts":"2026-05-04T18:51:09.504889Z","caller":"traceutil/trace.go:171","msg":"trace[372228948] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"107.137066ms","start":"2026-05-04T18:51:09.397719Z","end":"2026-05-04T18:51:09.504856Z","steps":["trace[372228948] 'process raft request'  (duration: 98.581764ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:51:09.660137Z","caller":"traceutil/trace.go:171","msg":"trace[560205305] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"140.700097ms","start":"2026-05-04T18:51:09.519398Z","end":"2026-05-04T18:51:09.660099Z","steps":["trace[560205305] 'process raft request'  (duration: 106.109687ms)","trace[560205305] 'compare'  (duration: 34.387917ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:51:09.866888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.705969ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186072128377627 > lease_revoke:<id:452d9df453dd51f4>","response":"size:29"}
{"level":"info","ts":"2026-05-04T18:51:10.230134Z","caller":"traceutil/trace.go:171","msg":"trace[1729495677] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"307.242832ms","start":"2026-05-04T18:51:09.922839Z","end":"2026-05-04T18:51:10.230082Z","steps":["trace[1729495677] 'process raft request'  (duration: 306.912495ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:51:10.231051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:51:09.922826Z","time spent":"307.427085ms","remote":"127.0.0.1:41024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:605 > 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-05-04T18:51:10.279353Z","caller":"traceutil/trace.go:171","msg":"trace[1657016399] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"348.878015ms","start":"2026-05-04T18:51:09.930451Z","end":"2026-05-04T18:51:10.279329Z","steps":["trace[1657016399] 'process raft request'  (duration: 348.304593ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:51:10.279529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:51:09.93042Z","time spent":"349.000236ms","remote":"127.0.0.1:40870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:617 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036201 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-05-04T18:51:25.21721Z","caller":"traceutil/trace.go:171","msg":"trace[728701638] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"160.700074ms","start":"2026-05-04T18:51:25.056484Z","end":"2026-05-04T18:51:25.217184Z","steps":["trace[728701638] 'process raft request'  (duration: 160.532841ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:51:58.919152Z","caller":"traceutil/trace.go:171","msg":"trace[1255525538] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"108.402269ms","start":"2026-05-04T18:51:58.810717Z","end":"2026-05-04T18:51:58.919119Z","steps":["trace[1255525538] 'process raft request'  (duration: 108.247167ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:52:20.097282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.163472ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186072128378630 > lease_revoke:<id:452d9df453dd567a>","response":"size:29"}
{"level":"info","ts":"2026-05-04T18:52:20.097453Z","caller":"traceutil/trace.go:171","msg":"trace[953004399] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1102; }","duration":"124.135878ms","start":"2026-05-04T18:52:19.973292Z","end":"2026-05-04T18:52:20.097428Z","steps":["trace[953004399] 'read index received'  (duration: 37.581µs)","trace[953004399] 'applied index is now lower than readState.Index'  (duration: 124.095327ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:52:20.097731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.382362ms","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-05-04T18:52:20.097827Z","caller":"traceutil/trace.go:171","msg":"trace[2137377520] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1065; }","duration":"124.566836ms","start":"2026-05-04T18:52:19.973241Z","end":"2026-05-04T18:52:20.097808Z","steps":["trace[2137377520] 'agreement among raft nodes before linearized reading'  (duration: 124.25366ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:52:25.706433Z","caller":"traceutil/trace.go:171","msg":"trace[1229571839] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"120.038987ms","start":"2026-05-04T18:52:25.586356Z","end":"2026-05-04T18:52:25.706395Z","steps":["trace[1229571839] 'process raft request'  (duration: 119.68853ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:52:38.330986Z","caller":"traceutil/trace.go:171","msg":"trace[1154804733] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"115.722813ms","start":"2026-05-04T18:52:38.215236Z","end":"2026-05-04T18:52:38.330958Z","steps":["trace[1154804733] 'process raft request'  (duration: 115.58004ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:52:55.147523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.88383ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186072128379056 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-lrll9.18ac718660fbfdb2\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-lrll9.18ac718660fbfdb2\" value_size:732 lease:4984814035273603190 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-04T18:52:55.147728Z","caller":"traceutil/trace.go:171","msg":"trace[833740191] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"205.323345ms","start":"2026-05-04T18:52:54.94234Z","end":"2026-05-04T18:52:55.147664Z","steps":["trace[833740191] 'process raft request'  (duration: 100.013146ms)","trace[833740191] 'compare'  (duration: 104.691777ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:52:55.14785Z","caller":"traceutil/trace.go:171","msg":"trace[1662666017] linearizableReadLoop","detail":"{readStateIndex:1301; appliedIndex:1300; }","duration":"204.127021ms","start":"2026-05-04T18:52:54.943706Z","end":"2026-05-04T18:52:55.147833Z","steps":["trace[1662666017] 'read index received'  (duration: 67.825576ms)","trace[1662666017] 'applied index is now lower than readState.Index'  (duration: 136.299465ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:52:55.148078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.365956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-04T18:52:55.147753Z","caller":"traceutil/trace.go:171","msg":"trace[229000903] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"126.888161ms","start":"2026-05-04T18:52:55.020838Z","end":"2026-05-04T18:52:55.147727Z","steps":["trace[229000903] 'process raft request'  (duration: 126.79492ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:52:55.14812Z","caller":"traceutil/trace.go:171","msg":"trace[1467313690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1255; }","duration":"204.440157ms","start":"2026-05-04T18:52:54.94367Z","end":"2026-05-04T18:52:55.14811Z","steps":["trace[1467313690] 'agreement among raft nodes before linearized reading'  (duration: 204.256643ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:52:55.305573Z","caller":"traceutil/trace.go:171","msg":"trace[1412122392] linearizableReadLoop","detail":"{readStateIndex:1303; appliedIndex:1302; }","duration":"157.642402ms","start":"2026-05-04T18:52:55.147893Z","end":"2026-05-04T18:52:55.305535Z","steps":["trace[1412122392] 'read index received'  (duration: 137.326795ms)","trace[1412122392] 'applied index is now lower than readState.Index'  (duration: 20.314457ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:52:55.305667Z","caller":"traceutil/trace.go:171","msg":"trace[834014777] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"159.208222ms","start":"2026-05-04T18:52:55.14642Z","end":"2026-05-04T18:52:55.305629Z","steps":["trace[834014777] 'process raft request'  (duration: 138.805734ms)","trace[834014777] 'compare'  (duration: 20.143133ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:52:55.305876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.280336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-05-04T18:52:55.305919Z","caller":"traceutil/trace.go:171","msg":"trace[1250415546] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1256; }","duration":"291.353937ms","start":"2026-05-04T18:52:55.01455Z","end":"2026-05-04T18:52:55.305903Z","steps":["trace[1250415546] 'agreement among raft nodes before linearized reading'  (duration: 291.116902ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:52:55.311551Z","caller":"traceutil/trace.go:171","msg":"trace[1586898691] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"159.432627ms","start":"2026-05-04T18:52:55.152105Z","end":"2026-05-04T18:52:55.311538Z","steps":["trace[1586898691] 'process raft request'  (duration: 159.366596ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:52:55.521119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.568846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:52:55.521114Z","caller":"traceutil/trace.go:171","msg":"trace[1701190995] linearizableReadLoop","detail":"{readStateIndex:1306; appliedIndex:1305; }","duration":"143.434554ms","start":"2026-05-04T18:52:55.377515Z","end":"2026-05-04T18:52:55.520949Z","steps":["trace[1701190995] 'read index received'  (duration: 91.989238ms)","trace[1701190995] 'applied index is now lower than readState.Index'  (duration: 51.443666ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:52:55.52122Z","caller":"traceutil/trace.go:171","msg":"trace[1783619466] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1259; }","duration":"143.71953ms","start":"2026-05-04T18:52:55.377478Z","end":"2026-05-04T18:52:55.521197Z","steps":["trace[1783619466] 'agreement among raft nodes before linearized reading'  (duration: 143.496915ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:52:55.521246Z","caller":"traceutil/trace.go:171","msg":"trace[812164965] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"166.828221ms","start":"2026-05-04T18:52:55.354357Z","end":"2026-05-04T18:52:55.521185Z","steps":["trace[812164965] 'process raft request'  (duration: 115.191832ms)","trace[812164965] 'compare'  (duration: 51.251942ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:52:55.521527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.164069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:52:55.521597Z","caller":"traceutil/trace.go:171","msg":"trace[768674960] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1259; }","duration":"120.336633ms","start":"2026-05-04T18:52:55.401239Z","end":"2026-05-04T18:52:55.521575Z","steps":["trace[768674960] 'agreement among raft nodes before linearized reading'  (duration: 120.130548ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:52:56.165282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.7044ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186072128379072 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1244 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T18:52:56.165436Z","caller":"traceutil/trace.go:171","msg":"trace[1491838825] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"249.217402ms","start":"2026-05-04T18:52:55.91619Z","end":"2026-05-04T18:52:56.165408Z","steps":["trace[1491838825] 'process raft request'  (duration: 106.272627ms)","trace[1491838825] 'compare'  (duration: 142.524987ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:53:09.930633Z","caller":"traceutil/trace.go:171","msg":"trace[1446225309] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"148.769169ms","start":"2026-05-04T18:53:09.781837Z","end":"2026-05-04T18:53:09.930606Z","steps":["trace[1446225309] 'process raft request'  (duration: 148.581605ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:53:10.264014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.615644ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186072128379252 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1342 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T18:53:10.26413Z","caller":"traceutil/trace.go:171","msg":"trace[1293176629] linearizableReadLoop","detail":"{readStateIndex:1403; appliedIndex:1402; }","duration":"284.352749ms","start":"2026-05-04T18:53:09.979762Z","end":"2026-05-04T18:53:10.264114Z","steps":["trace[1293176629] 'read index received'  (duration: 85.43422ms)","trace[1293176629] 'applied index is now lower than readState.Index'  (duration: 198.916939ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:53:10.264568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.788048ms","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-05-04T18:53:10.264777Z","caller":"traceutil/trace.go:171","msg":"trace[2077966386] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1353; }","duration":"285.043932ms","start":"2026-05-04T18:53:09.979715Z","end":"2026-05-04T18:53:10.264759Z","steps":["trace[2077966386] 'agreement among raft nodes before linearized reading'  (duration: 284.713436ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:53:10.264763Z","caller":"traceutil/trace.go:171","msg":"trace[626818850] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"315.696822ms","start":"2026-05-04T18:53:09.949049Z","end":"2026-05-04T18:53:10.264746Z","steps":["trace[626818850] 'process raft request'  (duration: 116.266533ms)","trace[626818850] 'compare'  (duration: 198.39318ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:53:10.264912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:53:09.949013Z","time spent":"315.866197ms","remote":"127.0.0.1:41024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1342 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-04T18:56:31.342267Z","caller":"traceutil/trace.go:171","msg":"trace[105235139] transaction","detail":"{read_only:false; response_revision:2304; number_of_response:1; }","duration":"100.048311ms","start":"2026-05-04T18:56:31.242194Z","end":"2026-05-04T18:56:31.342242Z","steps":["trace[105235139] 'process raft request'  (duration: 99.809577ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:56:31.496821Z","caller":"traceutil/trace.go:171","msg":"trace[32174227] linearizableReadLoop","detail":"{readStateIndex:2397; appliedIndex:2395; }","duration":"120.423594ms","start":"2026-05-04T18:56:31.376362Z","end":"2026-05-04T18:56:31.496785Z","steps":["trace[32174227] 'read index received'  (duration: 80.85637ms)","trace[32174227] 'applied index is now lower than readState.Index'  (duration: 39.565814ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:56:31.496869Z","caller":"traceutil/trace.go:171","msg":"trace[978392782] transaction","detail":"{read_only:false; response_revision:2305; number_of_response:1; }","duration":"149.604664ms","start":"2026-05-04T18:56:31.34721Z","end":"2026-05-04T18:56:31.496815Z","steps":["trace[978392782] 'process raft request'  (duration: 109.724273ms)","trace[978392782] 'compare'  (duration: 39.580235ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:56:31.497026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.626358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:56:31.497003Z","caller":"traceutil/trace.go:171","msg":"trace[1659809329] transaction","detail":"{read_only:false; response_revision:2306; number_of_response:1; }","duration":"149.246697ms","start":"2026-05-04T18:56:31.347711Z","end":"2026-05-04T18:56:31.496958Z","steps":["trace[1659809329] 'process raft request'  (duration: 149.000973ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:56:31.497078Z","caller":"traceutil/trace.go:171","msg":"trace[1033371636] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2306; }","duration":"120.71137ms","start":"2026-05-04T18:56:31.376354Z","end":"2026-05-04T18:56:31.497065Z","steps":["trace[1033371636] 'agreement among raft nodes before linearized reading'  (duration: 120.601758ms)"],"step_count":1}