{"level":"warn","ts":"2026-04-26T14:52:00.025968Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-26T14:52:00.026056Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3: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.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3: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-04-26T14:52:00.026142Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-26T14:52:00.026984Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-04-26T14:52:00.027046Z","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-04-26T14:52:00.027863Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-04-26T14:52:00.027945Z","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.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3: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-04-26T14:52:00.033592Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.154552ms"} {"level":"info","ts":"2026-04-26T14:52:00.046606Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-04-26T14:52:00.046722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-04-26T14:52:00.046755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-04-26T14:52:00.04678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-26T14:52:00.046802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-04-26T14:52:00.04686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-04-26T14:52:00.063081Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-26T14:52:00.067678Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-26T14:52:00.070517Z","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-04-26T14:52:00.076015Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-26T14:52:00.079533Z","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-04-26T14:52:00.079633Z","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-04-26T14:52:00.079665Z","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-04-26T14:52:00.079916Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-26T14:52:00.080723Z","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-04-26T14:52:00.080836Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-04-26T14:52:00.080885Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-04-26T14:52:00.080997Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-26T14:52:00.081059Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-26T14:52:00.081434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-04-26T14:52:00.081581Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-04-26T14:52:00.147927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-04-26T14:52:00.147973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-26T14:52:00.147995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-04-26T14:52:00.148008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-04-26T14:52:00.148015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-04-26T14:52:00.148026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-04-26T14:52:00.148035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-04-26T14:52:00.149345Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T14:52:00.149928Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-04-26T14:52:00.150041Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-26T14:52:00.150069Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-26T14:52:00.152103Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-04-26T14:52:00.15261Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-26T14:52:00.152629Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-26T14:52:00.153019Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-26T14:52:00.156712Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T14:52:00.156813Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T14:52:00.156836Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-26T14:52:29.00682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.056999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:52:29.006959Z","caller":"traceutil/trace.go:171","msg":"trace[575192711] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:540; }","duration":"190.29181ms","start":"2026-04-26T14:52:28.816647Z","end":"2026-04-26T14:52:29.006939Z","steps":["trace[575192711] 'range keys from in-memory index tree' (duration: 189.982859ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:52:30.192841Z","caller":"traceutil/trace.go:171","msg":"trace[515466841] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:567; }","duration":"149.974123ms","start":"2026-04-26T14:52:30.042825Z","end":"2026-04-26T14:52:30.1928Z","steps":["trace[515466841] 'read index received' (duration: 148.359576ms)","trace[515466841] 'applied index is now lower than readState.Index' (duration: 1.613696ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:52:30.192976Z","caller":"traceutil/trace.go:171","msg":"trace[1010746430] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"177.502618ms","start":"2026-04-26T14:52:30.01545Z","end":"2026-04-26T14:52:30.192952Z","steps":["trace[1010746430] 'process raft request' (duration: 175.684935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:52:30.193049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.215917ms","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-04-26T14:52:30.193092Z","caller":"traceutil/trace.go:171","msg":"trace[966557498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:546; }","duration":"150.306898ms","start":"2026-04-26T14:52:30.042776Z","end":"2026-04-26T14:52:30.193083Z","steps":["trace[966557498] 'agreement among raft nodes before linearized reading' (duration: 150.167066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:52:30.193182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.979961ms","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-04-26T14:52:30.193273Z","caller":"traceutil/trace.go:171","msg":"trace[174274324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:546; }","duration":"144.102949ms","start":"2026-04-26T14:52:30.049147Z","end":"2026-04-26T14:52:30.19325Z","steps":["trace[174274324] 'agreement among raft nodes before linearized reading' (duration: 143.84066ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:52:32.378849Z","caller":"traceutil/trace.go:171","msg":"trace[1965286026] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"177.792553ms","start":"2026-04-26T14:52:32.201029Z","end":"2026-04-26T14:52:32.378821Z","steps":["trace[1965286026] 'process raft request' (duration: 177.575294ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:52:32.379756Z","caller":"traceutil/trace.go:171","msg":"trace[590794622] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:580; }","duration":"175.258469ms","start":"2026-04-26T14:52:32.204469Z","end":"2026-04-26T14:52:32.379727Z","steps":["trace[590794622] 'read index received' (duration: 173.992002ms)","trace[590794622] 'applied index is now lower than readState.Index' (duration: 1.264037ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:52:32.379956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.462126ms","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-04-26T14:52:32.379996Z","caller":"traceutil/trace.go:171","msg":"trace[958576190] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:558; }","duration":"175.519149ms","start":"2026-04-26T14:52:32.204466Z","end":"2026-04-26T14:52:32.379985Z","steps":["trace[958576190] 'agreement among raft nodes before linearized reading' (duration: 175.401562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:52:32.380183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.6615ms","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-04-26T14:52:32.380214Z","caller":"traceutil/trace.go:171","msg":"trace[689156138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:558; }","duration":"175.70182ms","start":"2026-04-26T14:52:32.204505Z","end":"2026-04-26T14:52:32.380207Z","steps":["trace[689156138] 'agreement among raft nodes before linearized reading' (duration: 175.595206ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:52:32.490921Z","caller":"traceutil/trace.go:171","msg":"trace[265540558] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"106.613251ms","start":"2026-04-26T14:52:32.384292Z","end":"2026-04-26T14:52:32.490906Z","steps":["trace[265540558] 'process raft request' (duration: 106.442673ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:52:32.492639Z","caller":"traceutil/trace.go:171","msg":"trace[485968488] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"108.098828ms","start":"2026-04-26T14:52:32.384527Z","end":"2026-04-26T14:52:32.492626Z","steps":["trace[485968488] 'process raft request' (duration: 108.051148ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:52:47.596276Z","caller":"traceutil/trace.go:171","msg":"trace[168729229] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"261.121671ms","start":"2026-04-26T14:52:47.335121Z","end":"2026-04-26T14:52:47.596243Z","steps":["trace[168729229] 'process raft request' (duration: 260.954255ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:56:01.073451Z","caller":"traceutil/trace.go:171","msg":"trace[694941298] transaction","detail":"{read_only:false; response_revision:1456; number_of_response:1; }","duration":"269.373326ms","start":"2026-04-26T14:56:00.80405Z","end":"2026-04-26T14:56:01.073424Z","steps":["trace[694941298] 'process raft request' (duration: 269.252373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:56:01.264647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.314526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-26T14:56:01.264721Z","caller":"traceutil/trace.go:171","msg":"trace[1087866605] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1456; }","duration":"110.45048ms","start":"2026-04-26T14:56:01.154255Z","end":"2026-04-26T14:56:01.264706Z","steps":["trace[1087866605] 'range keys from in-memory index tree' (duration: 110.099601ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:56:25.325734Z","caller":"traceutil/trace.go:171","msg":"trace[33533499] transaction","detail":"{read_only:false; response_revision:1535; number_of_response:1; }","duration":"141.665884ms","start":"2026-04-26T14:56:25.18404Z","end":"2026-04-26T14:56:25.325706Z","steps":["trace[33533499] 'process raft request' (duration: 141.499559ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:56:25.690835Z","caller":"traceutil/trace.go:171","msg":"trace[1376894587] linearizableReadLoop","detail":"{readStateIndex:1609; appliedIndex:1608; }","duration":"128.318899ms","start":"2026-04-26T14:56:25.562489Z","end":"2026-04-26T14:56:25.690808Z","steps":["trace[1376894587] 'read index received' (duration: 128.149125ms)","trace[1376894587] 'applied index is now lower than readState.Index' (duration: 168.224µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:56:25.690907Z","caller":"traceutil/trace.go:171","msg":"trace[122197858] transaction","detail":"{read_only:false; response_revision:1538; number_of_response:1; }","duration":"129.199892ms","start":"2026-04-26T14:56:25.561663Z","end":"2026-04-26T14:56:25.690863Z","steps":["trace[122197858] 'process raft request' (duration: 128.985967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:56:25.691138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.619357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-26T14:56:25.691183Z","caller":"traceutil/trace.go:171","msg":"trace[703247590] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1538; }","duration":"128.7396ms","start":"2026-04-26T14:56:25.562431Z","end":"2026-04-26T14:56:25.691171Z","steps":["trace[703247590] 'agreement among raft nodes before linearized reading' (duration: 128.519305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:56:25.691296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.72475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-26T14:56:25.691419Z","caller":"traceutil/trace.go:171","msg":"trace[2135756512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1538; }","duration":"128.926035ms","start":"2026-04-26T14:56:25.562473Z","end":"2026-04-26T14:56:25.691399Z","steps":["trace[2135756512] 'agreement among raft nodes before linearized reading' (duration: 128.583726ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:56:37.516448Z","caller":"traceutil/trace.go:171","msg":"trace[58774769] transaction","detail":"{read_only:false; response_revision:1626; number_of_response:1; }","duration":"143.287285ms","start":"2026-04-26T14:56:37.37314Z","end":"2026-04-26T14:56:37.516427Z","steps":["trace[58774769] 'process raft request' (duration: 143.160372ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:56:37.518545Z","caller":"traceutil/trace.go:171","msg":"trace[1889844691] transaction","detail":"{read_only:false; response_revision:1627; number_of_response:1; }","duration":"115.716366ms","start":"2026-04-26T14:56:37.402802Z","end":"2026-04-26T14:56:37.518519Z","steps":["trace[1889844691] 'process raft request' (duration: 115.465749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:56:51.895221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.656777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-26T14:56:51.895308Z","caller":"traceutil/trace.go:171","msg":"trace[1472844169] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1674; }","duration":"104.7838ms","start":"2026-04-26T14:56:51.790504Z","end":"2026-04-26T14:56:51.895288Z","steps":["trace[1472844169] 'range keys from in-memory index tree' (duration: 104.509024ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:56:53.791103Z","caller":"traceutil/trace.go:171","msg":"trace[1511660129] transaction","detail":"{read_only:false; response_revision:1689; number_of_response:1; }","duration":"104.949265ms","start":"2026-04-26T14:56:53.686128Z","end":"2026-04-26T14:56:53.791077Z","steps":["trace[1511660129] 'process raft request' (duration: 104.72928ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:56:57.928816Z","caller":"traceutil/trace.go:171","msg":"trace[431242398] transaction","detail":"{read_only:false; response_revision:1748; number_of_response:1; }","duration":"124.752037ms","start":"2026-04-26T14:56:57.804044Z","end":"2026-04-26T14:56:57.928796Z","steps":["trace[431242398] 'process raft request' (duration: 124.608263ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:57:00.12494Z","caller":"traceutil/trace.go:171","msg":"trace[1991505986] linearizableReadLoop","detail":"{readStateIndex:1834; appliedIndex:1833; }","duration":"152.042733ms","start":"2026-04-26T14:56:59.972875Z","end":"2026-04-26T14:57:00.124918Z","steps":["trace[1991505986] 'read index received' (duration: 151.884319ms)","trace[1991505986] 'applied index is now lower than readState.Index' (duration: 157.244µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:57:00.125075Z","caller":"traceutil/trace.go:171","msg":"trace[184717691] transaction","detail":"{read_only:false; response_revision:1754; number_of_response:1; }","duration":"188.077039ms","start":"2026-04-26T14:56:59.936957Z","end":"2026-04-26T14:57:00.125034Z","steps":["trace[184717691] 'process raft request' (duration: 187.800503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:57:00.125217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.32531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-26T14:57:00.125319Z","caller":"traceutil/trace.go:171","msg":"trace[1239175192] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1754; }","duration":"152.479473ms","start":"2026-04-26T14:56:59.972818Z","end":"2026-04-26T14:57:00.125298Z","steps":["trace[1239175192] 'agreement among raft nodes before linearized reading' (duration: 152.217866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:57:00.146754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.475597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-26T14:57:00.146831Z","caller":"traceutil/trace.go:171","msg":"trace[1879749373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1755; }","duration":"105.589661ms","start":"2026-04-26T14:57:00.041222Z","end":"2026-04-26T14:57:00.146811Z","steps":["trace[1879749373] 'agreement among raft nodes before linearized reading' (duration: 105.395836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:57:00.14691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.573861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-26T14:57:00.147078Z","caller":"traceutil/trace.go:171","msg":"trace[1762199047] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1755; }","duration":"105.810136ms","start":"2026-04-26T14:57:00.041171Z","end":"2026-04-26T14:57:00.146982Z","steps":["trace[1762199047] 'agreement among raft nodes before linearized reading' (duration: 105.440757ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:57:00.28922Z","caller":"traceutil/trace.go:171","msg":"trace[1912376691] transaction","detail":"{read_only:false; response_revision:1757; number_of_response:1; }","duration":"137.518979ms","start":"2026-04-26T14:57:00.151674Z","end":"2026-04-26T14:57:00.289193Z","steps":["trace[1912376691] 'process raft request' (duration: 111.810553ms)","trace[1912376691] 'compare' (duration: 25.527091ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:57:00.289662Z","caller":"traceutil/trace.go:171","msg":"trace[386363661] linearizableReadLoop","detail":"{readStateIndex:1838; appliedIndex:1836; }","duration":"137.569651ms","start":"2026-04-26T14:57:00.152063Z","end":"2026-04-26T14:57:00.289632Z","steps":["trace[386363661] 'read index received' (duration: 111.435784ms)","trace[386363661] 'applied index is now lower than readState.Index' (duration: 26.132597ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:57:00.289682Z","caller":"traceutil/trace.go:171","msg":"trace[245281365] transaction","detail":"{read_only:false; response_revision:1758; number_of_response:1; }","duration":"137.652702ms","start":"2026-04-26T14:57:00.151993Z","end":"2026-04-26T14:57:00.289645Z","steps":["trace[245281365] 'process raft request' (duration: 137.15517ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:57:00.289727Z","caller":"traceutil/trace.go:171","msg":"trace[1154389773] transaction","detail":"{read_only:false; response_revision:1759; number_of_response:1; }","duration":"137.313473ms","start":"2026-04-26T14:57:00.152399Z","end":"2026-04-26T14:57:00.289712Z","steps":["trace[1154389773] 'process raft request' (duration: 137.126338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:57:00.28997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.878298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1783"} {"level":"info","ts":"2026-04-26T14:57:00.29002Z","caller":"traceutil/trace.go:171","msg":"trace[414787493] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1759; }","duration":"137.959379ms","start":"2026-04-26T14:57:00.152048Z","end":"2026-04-26T14:57:00.290007Z","steps":["trace[414787493] 'agreement among raft nodes before linearized reading' (duration: 137.740064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:57:00.290033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.155723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-04-26T14:57:00.2901Z","caller":"traceutil/trace.go:171","msg":"trace[259444291] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1759; }","duration":"108.302417ms","start":"2026-04-26T14:57:00.18178Z","end":"2026-04-26T14:57:00.290083Z","steps":["trace[259444291] 'agreement among raft nodes before linearized reading' (duration: 108.067582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:57:12.831477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.548762ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:57:12.831562Z","caller":"traceutil/trace.go:171","msg":"trace[1276488175] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"491.600639ms","start":"2026-04-26T14:57:12.339947Z","end":"2026-04-26T14:57:12.831548Z","steps":["trace[1276488175] 'process raft request' (duration: 336.493813ms)","trace[1276488175] 'compare' (duration: 153.747283ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:57:12.831604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:57:12.339914Z","time spent":"491.670821ms","remote":"127.0.0.1:40410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T14:57:12.852807Z","caller":"traceutil/trace.go:171","msg":"trace[1903322251] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1930; }","duration":"206.004376ms","start":"2026-04-26T14:57:12.646787Z","end":"2026-04-26T14:57:12.852791Z","steps":["trace[1903322251] 'read index received' (duration: 29.656372ms)","trace[1903322251] 'applied index is now lower than readState.Index' (duration: 176.347444ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:57:12.852889Z","caller":"traceutil/trace.go:171","msg":"trace[1892252956] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"512.886067ms","start":"2026-04-26T14:57:12.339971Z","end":"2026-04-26T14:57:12.852857Z","steps":["trace[1892252956] 'process raft request' (duration: 512.737583ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:57:12.852969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.17634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-26T14:57:12.852994Z","caller":"traceutil/trace.go:171","msg":"trace[404240145] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1850; }","duration":"206.288573ms","start":"2026-04-26T14:57:12.646697Z","end":"2026-04-26T14:57:12.852985Z","steps":["trace[404240145] 'agreement among raft nodes before linearized reading' (duration: 206.184661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:57:12.852998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.235421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:57:12.853044Z","caller":"traceutil/trace.go:171","msg":"trace[618661116] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1850; }","duration":"176.313342ms","start":"2026-04-26T14:57:12.676718Z","end":"2026-04-26T14:57:12.853032Z","steps":["trace[618661116] 'agreement among raft nodes before linearized reading' (duration: 176.2238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:57:12.853039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:57:12.339954Z","time spent":"513.002871ms","remote":"127.0.0.1:40410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:57:12.853067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.701898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:57:12.853132Z","caller":"traceutil/trace.go:171","msg":"trace[1239739259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1850; }","duration":"106.79119ms","start":"2026-04-26T14:57:12.746323Z","end":"2026-04-26T14:57:12.853114Z","steps":["trace[1239739259] 'agreement among raft nodes before linearized reading' (duration: 106.653957ms)"],"step_count":1}