{"level":"warn","ts":"2026-04-08T06:18:07.50534Z","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-08T06:18:07.505463Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.69: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.69:2380","--initial-cluster=instance=https://199.204.45.69:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.69:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.69: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-08T06:18:07.505538Z","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-08T06:18:07.505554Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.69:2380"]} {"level":"info","ts":"2026-04-08T06:18:07.505585Z","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-08T06:18:07.506998Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"]} {"level":"info","ts":"2026-04-08T06:18:07.507096Z","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":16,"max-cpu-available":16,"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.69:2380"],"listen-peer-urls":["https://199.204.45.69:2380"],"advertise-client-urls":["https://199.204.45.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.69: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-08T06:18:07.511057Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.673856ms"} {"level":"info","ts":"2026-04-08T06:18:07.51839Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fe334179879fd0aa","cluster-id":"d79a8cccc23ced73"} {"level":"info","ts":"2026-04-08T06:18:07.51848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T06:18:07.518503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became follower at term 0"} {"level":"info","ts":"2026-04-08T06:18:07.518516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fe334179879fd0aa [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T06:18:07.518532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became follower at term 1"} {"level":"info","ts":"2026-04-08T06:18:07.518564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=(18317056099668185258)"} {"level":"warn","ts":"2026-04-08T06:18:07.530251Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T06:18:07.531894Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T06:18:07.532906Z","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-08T06:18:07.534985Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fe334179879fd0aa","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T06:18:07.535432Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fe334179879fd0aa","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T06:18:07.535671Z","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-08T06:18:07.535787Z","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-08T06:18:07.535802Z","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-08T06:18:07.538638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=(18317056099668185258)"} {"level":"info","ts":"2026-04-08T06:18:07.538776Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d79a8cccc23ced73","local-member-id":"fe334179879fd0aa","added-peer-id":"fe334179879fd0aa","added-peer-peer-urls":["https://199.204.45.69:2380"]} {"level":"info","ts":"2026-04-08T06:18:07.541269Z","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-08T06:18:07.54143Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.69:2380"} {"level":"info","ts":"2026-04-08T06:18:07.541457Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.69:2380"} {"level":"info","ts":"2026-04-08T06:18:07.541639Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fe334179879fd0aa","initial-advertise-peer-urls":["https://199.204.45.69:2380"],"listen-peer-urls":["https://199.204.45.69:2380"],"advertise-client-urls":["https://199.204.45.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T06:18:07.541696Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T06:18:08.319701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T06:18:08.319766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T06:18:08.319806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa received MsgPreVoteResp from fe334179879fd0aa at term 1"} {"level":"info","ts":"2026-04-08T06:18:08.319825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became candidate at term 2"} {"level":"info","ts":"2026-04-08T06:18:08.319835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa received MsgVoteResp from fe334179879fd0aa at term 2"} {"level":"info","ts":"2026-04-08T06:18:08.319851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became leader at term 2"} {"level":"info","ts":"2026-04-08T06:18:08.319877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fe334179879fd0aa elected leader fe334179879fd0aa at term 2"} {"level":"info","ts":"2026-04-08T06:18:08.321067Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:18:08.321957Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fe334179879fd0aa","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.69:2379]}","request-path":"/0/members/fe334179879fd0aa/attributes","cluster-id":"d79a8cccc23ced73","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T06:18:08.322137Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:18:08.322208Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:18:08.322568Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d79a8cccc23ced73","local-member-id":"fe334179879fd0aa","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:18:08.322801Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:18:08.322854Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:18:08.325075Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.69:2379"} {"level":"info","ts":"2026-04-08T06:18:08.325164Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T06:18:08.325172Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T06:18:08.325229Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-04-08T06:18:24.381296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.342279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-08T06:18:24.381493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.407886ms","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-04-08T06:18:24.381546Z","caller":"traceutil/trace.go:171","msg":"trace[1192183684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:375; }","duration":"193.509388ms","start":"2026-04-08T06:18:24.188019Z","end":"2026-04-08T06:18:24.381529Z","steps":["trace[1192183684] 'range keys from in-memory index tree' (duration: 193.223992ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:24.38167Z","caller":"traceutil/trace.go:171","msg":"trace[1512737576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:375; }","duration":"119.568524ms","start":"2026-04-08T06:18:24.261914Z","end":"2026-04-08T06:18:24.381483Z","steps":["trace[1512737576] 'range keys from in-memory index tree' (duration: 119.201816ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:24.509716Z","caller":"traceutil/trace.go:171","msg":"trace[276384038] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"123.371685ms","start":"2026-04-08T06:18:24.386314Z","end":"2026-04-08T06:18:24.509685Z","steps":["trace[276384038] 'process raft request' (duration: 123.185511ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:24.517657Z","caller":"traceutil/trace.go:171","msg":"trace[1732763214] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"131.055108ms","start":"2026-04-08T06:18:24.386573Z","end":"2026-04-08T06:18:24.517628Z","steps":["trace[1732763214] 'process raft request' (duration: 130.918645ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:54.443186Z","caller":"traceutil/trace.go:171","msg":"trace[137299380] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"159.222527ms","start":"2026-04-08T06:18:54.283931Z","end":"2026-04-08T06:18:54.443154Z","steps":["trace[137299380] 'process raft request' (duration: 158.444389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:55.05152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.237321ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:18:55.051609Z","caller":"traceutil/trace.go:171","msg":"trace[882584268] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"384.688355ms","start":"2026-04-08T06:18:54.666909Z","end":"2026-04-08T06:18:55.051597Z","steps":["trace[882584268] 'process raft request' (duration: 223.943502ms)","trace[882584268] 'compare' (duration: 160.147849ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:18:55.051652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:18:54.666898Z","time spent":"384.733626ms","remote":"127.0.0.1:55746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T06:18:55.067605Z","caller":"traceutil/trace.go:171","msg":"trace[967618026] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"399.685153ms","start":"2026-04-08T06:18:54.667898Z","end":"2026-04-08T06:18:55.067583Z","steps":["trace[967618026] 'process raft request' (duration: 399.584291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:55.06774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:18:54.667886Z","time spent":"399.789206ms","remote":"127.0.0.1:55746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:19:10.690356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.483082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T06:19:10.690547Z","caller":"traceutil/trace.go:171","msg":"trace[2101288213] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:767; }","duration":"195.747908ms","start":"2026-04-08T06:19:10.494781Z","end":"2026-04-08T06:19:10.690529Z","steps":["trace[2101288213] 'count revisions from in-memory index tree' (duration: 195.309949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:10.690548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.444586ms","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-04-08T06:19:10.6906Z","caller":"traceutil/trace.go:171","msg":"trace[540373653] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:767; }","duration":"318.536418ms","start":"2026-04-08T06:19:10.372051Z","end":"2026-04-08T06:19:10.690587Z","steps":["trace[540373653] 'range keys from in-memory index tree' (duration: 318.301162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:10.690624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:19:10.372007Z","time spent":"318.611439ms","remote":"127.0.0.1:55746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-08T06:19:27.444581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.784029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:19:27.444894Z","caller":"traceutil/trace.go:171","msg":"trace[1387680173] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"162.362223ms","start":"2026-04-08T06:19:27.282492Z","end":"2026-04-08T06:19:27.444855Z","steps":["trace[1387680173] 'process raft request' (duration: 26.228685ms)","trace[1387680173] 'compare' (duration: 135.627216ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:19:27.444949Z","caller":"traceutil/trace.go:171","msg":"trace[1809011256] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"148.43349ms","start":"2026-04-08T06:19:27.296489Z","end":"2026-04-08T06:19:27.444922Z","steps":["trace[1809011256] 'process raft request' (duration: 148.266396ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:27.444936Z","caller":"traceutil/trace.go:171","msg":"trace[2143253830] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"142.805406ms","start":"2026-04-08T06:19:27.302108Z","end":"2026-04-08T06:19:27.444913Z","steps":["trace[2143253830] 'process raft request' (duration: 142.741935ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:27.44512Z","caller":"traceutil/trace.go:171","msg":"trace[1244965008] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"161.258607ms","start":"2026-04-08T06:19:27.283847Z","end":"2026-04-08T06:19:27.445106Z","steps":["trace[1244965008] 'process raft request' (duration: 160.846877ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:20:23.596071Z","caller":"traceutil/trace.go:171","msg":"trace[799428109] linearizableReadLoop","detail":"{readStateIndex:1907; appliedIndex:1906; }","duration":"305.30136ms","start":"2026-04-08T06:20:23.290745Z","end":"2026-04-08T06:20:23.596046Z","steps":["trace[799428109] 'read index received' (duration: 305.053554ms)","trace[799428109] 'applied index is now lower than readState.Index' (duration: 246.776µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:20:23.596129Z","caller":"traceutil/trace.go:171","msg":"trace[1441511988] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"455.833249ms","start":"2026-04-08T06:20:23.140266Z","end":"2026-04-08T06:20:23.596099Z","steps":["trace[1441511988] 'process raft request' (duration: 455.614164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:20:23.596305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.536925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1ed20eea-0982-4fe8-b2dc-de528dd8f640\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-08T06:20:23.596342Z","caller":"traceutil/trace.go:171","msg":"trace[1782060997] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1ed20eea-0982-4fe8-b2dc-de528dd8f640; range_end:; response_count:1; response_revision:1832; }","duration":"305.612998ms","start":"2026-04-08T06:20:23.290715Z","end":"2026-04-08T06:20:23.596328Z","steps":["trace[1782060997] 'agreement among raft nodes before linearized reading' (duration: 305.477184ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:20:23.59632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:20:23.140249Z","time spent":"455.941611ms","remote":"127.0.0.1:55746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:20:23.596309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.731208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T06:20:23.596376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:20:23.2907Z","time spent":"305.668618ms","remote":"127.0.0.1:55632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1ed20eea-0982-4fe8-b2dc-de528dd8f640\" "} {"level":"info","ts":"2026-04-08T06:20:23.596425Z","caller":"traceutil/trace.go:171","msg":"trace[1436001017] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1832; }","duration":"253.87533ms","start":"2026-04-08T06:20:23.342519Z","end":"2026-04-08T06:20:23.596394Z","steps":["trace[1436001017] 'agreement among raft nodes before linearized reading' (duration: 253.741547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:20:23.960449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.874329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:20:23.960565Z","caller":"traceutil/trace.go:171","msg":"trace[1877173334] linearizableReadLoop","detail":"{readStateIndex:1911; appliedIndex:1910; }","duration":"152.420974ms","start":"2026-04-08T06:20:23.808125Z","end":"2026-04-08T06:20:23.960546Z","steps":["trace[1877173334] 'read index received' (duration: 21.208657ms)","trace[1877173334] 'applied index is now lower than readState.Index' (duration: 131.211057ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:20:23.96067Z","caller":"traceutil/trace.go:171","msg":"trace[1329087797] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"161.210424ms","start":"2026-04-08T06:20:23.799446Z","end":"2026-04-08T06:20:23.960656Z","steps":["trace[1329087797] 'process raft request' (duration: 30.025457ms)","trace[1329087797] 'compare' (duration: 130.590843ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:20:23.960773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.274875ms","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-08T06:20:23.960828Z","caller":"traceutil/trace.go:171","msg":"trace[1122246454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1836; }","duration":"148.365368ms","start":"2026-04-08T06:20:23.812449Z","end":"2026-04-08T06:20:23.960814Z","steps":["trace[1122246454] 'agreement among raft nodes before linearized reading' (duration: 148.246765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:20:23.960898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.784052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-08T06:20:23.960881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.432025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T06:20:23.96093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.882844ms","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-04-08T06:20:23.96096Z","caller":"traceutil/trace.go:171","msg":"trace[515295034] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1836; }","duration":"144.946216ms","start":"2026-04-08T06:20:23.816007Z","end":"2026-04-08T06:20:23.960953Z","steps":["trace[515295034] 'agreement among raft nodes before linearized reading' (duration: 144.876434ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:20:23.960956Z","caller":"traceutil/trace.go:171","msg":"trace[1777853506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1836; }","duration":"152.901856ms","start":"2026-04-08T06:20:23.808038Z","end":"2026-04-08T06:20:23.96094Z","steps":["trace[1777853506] 'agreement among raft nodes before linearized reading' (duration: 152.760452ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:20:23.960972Z","caller":"traceutil/trace.go:171","msg":"trace[1317247287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1836; }","duration":"106.588409ms","start":"2026-04-08T06:20:23.854363Z","end":"2026-04-08T06:20:23.960951Z","steps":["trace[1317247287] 'agreement among raft nodes before linearized reading' (duration: 106.414645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:20:23.960341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.54487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-08T06:20:23.961179Z","caller":"traceutil/trace.go:171","msg":"trace[656629702] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1835; }","duration":"169.459651ms","start":"2026-04-08T06:20:23.791687Z","end":"2026-04-08T06:20:23.961147Z","steps":["trace[656629702] 'range keys from in-memory index tree' (duration: 168.261973ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:20:31.840653Z","caller":"traceutil/trace.go:171","msg":"trace[963930393] linearizableReadLoop","detail":"{readStateIndex:1984; appliedIndex:1983; }","duration":"123.76597ms","start":"2026-04-08T06:20:31.716863Z","end":"2026-04-08T06:20:31.840629Z","steps":["trace[963930393] 'read index received' (duration: 123.697038ms)","trace[963930393] 'applied index is now lower than readState.Index' (duration: 67.612µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:20:31.840763Z","caller":"traceutil/trace.go:171","msg":"trace[1697076620] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"157.376003ms","start":"2026-04-08T06:20:31.683354Z","end":"2026-04-08T06:20:31.84073Z","steps":["trace[1697076620] 'process raft request' (duration: 157.111147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:20:31.840817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.930004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:20:31.840876Z","caller":"traceutil/trace.go:171","msg":"trace[1426284341] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:1907; }","duration":"123.992715ms","start":"2026-04-08T06:20:31.716858Z","end":"2026-04-08T06:20:31.84085Z","steps":["trace[1426284341] 'agreement among raft nodes before linearized reading' (duration: 123.871092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:20:36.269542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.639147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:20:36.269609Z","caller":"traceutil/trace.go:171","msg":"trace[316229542] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1939; }","duration":"141.76867ms","start":"2026-04-08T06:20:36.127826Z","end":"2026-04-08T06:20:36.269595Z","steps":["trace[316229542] 'count revisions from in-memory index tree' (duration: 141.466854ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:21:08.448533Z","caller":"traceutil/trace.go:171","msg":"trace[937114285] linearizableReadLoop","detail":"{readStateIndex:2210; appliedIndex:2209; }","duration":"237.189092ms","start":"2026-04-08T06:21:08.211319Z","end":"2026-04-08T06:21:08.448508Z","steps":["trace[937114285] 'read index received' (duration: 231.26644ms)","trace[937114285] 'applied index is now lower than readState.Index' (duration: 5.921162ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:21:08.448557Z","caller":"traceutil/trace.go:171","msg":"trace[1883790604] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"251.432904ms","start":"2026-04-08T06:21:08.197091Z","end":"2026-04-08T06:21:08.448524Z","steps":["trace[1883790604] 'process raft request' (duration: 245.496142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:21:08.448726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.395247ms","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-04-08T06:21:08.448784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.047184ms","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-04-08T06:21:08.448793Z","caller":"traceutil/trace.go:171","msg":"trace[203581198] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2126; }","duration":"237.496529ms","start":"2026-04-08T06:21:08.211281Z","end":"2026-04-08T06:21:08.448777Z","steps":["trace[203581198] 'agreement among raft nodes before linearized reading' (duration: 237.318105ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:21:08.448822Z","caller":"traceutil/trace.go:171","msg":"trace[1008773626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2126; }","duration":"236.143306ms","start":"2026-04-08T06:21:08.212667Z","end":"2026-04-08T06:21:08.448811Z","steps":["trace[1008773626] 'agreement among raft nodes before linearized reading' (duration: 235.989793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:21:08.448859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.774004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T06:21:08.448913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.552761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-08T06:21:08.448941Z","caller":"traceutil/trace.go:171","msg":"trace[757080701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2126; }","duration":"160.92939ms","start":"2026-04-08T06:21:08.287983Z","end":"2026-04-08T06:21:08.448912Z","steps":["trace[757080701] 'agreement among raft nodes before linearized reading' (duration: 160.728305ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:21:08.448969Z","caller":"traceutil/trace.go:171","msg":"trace[824242604] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2126; }","duration":"180.695285ms","start":"2026-04-08T06:21:08.26826Z","end":"2026-04-08T06:21:08.448955Z","steps":["trace[824242604] 'agreement among raft nodes before linearized reading' (duration: 180.49839ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:21:14.839261Z","caller":"traceutil/trace.go:171","msg":"trace[1055643935] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"295.78484ms","start":"2026-04-08T06:21:14.543351Z","end":"2026-04-08T06:21:14.839136Z","steps":["trace[1055643935] 'process raft request' (duration: 281.804684ms)","trace[1055643935] 'compare' (duration: 13.596697ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:21:14.850323Z","caller":"traceutil/trace.go:171","msg":"trace[430200836] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"306.625321ms","start":"2026-04-08T06:21:14.543677Z","end":"2026-04-08T06:21:14.850303Z","steps":["trace[430200836] 'process raft request' (duration: 306.577399ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:21:14.850485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:21:14.54367Z","time spent":"306.731853ms","remote":"127.0.0.1:55746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T06:21:14.85061Z","caller":"traceutil/trace.go:171","msg":"trace[2034837063] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"307.179834ms","start":"2026-04-08T06:21:14.543405Z","end":"2026-04-08T06:21:14.850585Z","steps":["trace[2034837063] 'process raft request' (duration: 306.760814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:21:14.850728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:21:14.543382Z","time spent":"307.293267ms","remote":"127.0.0.1:55746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:21:15.205161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.061481ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:21:15.205304Z","caller":"traceutil/trace.go:171","msg":"trace[1956944608] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"293.818614ms","start":"2026-04-08T06:21:14.911466Z","end":"2026-04-08T06:21:15.205285Z","steps":["trace[1956944608] 'process raft request' (duration: 68.540277ms)","trace[1956944608] 'compare' (duration: 224.873647ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:26:36.490959Z","caller":"traceutil/trace.go:171","msg":"trace[974187018] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"130.639803ms","start":"2026-04-08T06:26:36.360301Z","end":"2026-04-08T06:26:36.490941Z","steps":["trace[974187018] 'process raft request' (duration: 130.530241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:26:36.64808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.00334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:26:36.64814Z","caller":"traceutil/trace.go:171","msg":"trace[2107426961] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:5029; }","duration":"123.101773ms","start":"2026-04-08T06:26:36.525023Z","end":"2026-04-08T06:26:36.648125Z","steps":["trace[2107426961] 'agreement among raft nodes before linearized reading' (duration: 122.98015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:26:36.648304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.788761ms","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-08T06:26:36.648372Z","caller":"traceutil/trace.go:171","msg":"trace[124515335] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5029; }","duration":"126.893134ms","start":"2026-04-08T06:26:36.521462Z","end":"2026-04-08T06:26:36.648356Z","steps":["trace[124515335] 'agreement among raft nodes before linearized reading' (duration: 126.72312ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:45.617756Z","caller":"traceutil/trace.go:171","msg":"trace[1713874761] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"100.473226ms","start":"2026-04-08T06:26:45.517262Z","end":"2026-04-08T06:26:45.617735Z","steps":["trace[1713874761] 'process raft request' (duration: 100.385624ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:45.618045Z","caller":"traceutil/trace.go:171","msg":"trace[1005790469] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"101.242155ms","start":"2026-04-08T06:26:45.516772Z","end":"2026-04-08T06:26:45.618014Z","steps":["trace[1005790469] 'process raft request' (duration: 62.432047ms)","trace[1005790469] 'compare' (duration: 38.344666ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:26:53.461851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.223679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210982"} {"level":"info","ts":"2026-04-08T06:26:53.461951Z","caller":"traceutil/trace.go:171","msg":"trace[1479964699] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5385; }","duration":"124.382093ms","start":"2026-04-08T06:26:53.33755Z","end":"2026-04-08T06:26:53.461932Z","steps":["trace[1479964699] 'range keys from in-memory index tree' (duration: 123.236935ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:53.779846Z","caller":"traceutil/trace.go:171","msg":"trace[144238239] linearizableReadLoop","detail":"{readStateIndex:5591; appliedIndex:5590; }","duration":"160.389233ms","start":"2026-04-08T06:26:53.619429Z","end":"2026-04-08T06:26:53.779818Z","steps":["trace[144238239] 'read index received' (duration: 95.099175ms)","trace[144238239] 'applied index is now lower than readState.Index' (duration: 65.288737ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:26:53.779869Z","caller":"traceutil/trace.go:171","msg":"trace[824844913] transaction","detail":"{read_only:false; response_revision:5387; number_of_response:1; }","duration":"173.54275ms","start":"2026-04-08T06:26:53.606301Z","end":"2026-04-08T06:26:53.779844Z","steps":["trace[824844913] 'process raft request' (duration: 108.266543ms)","trace[824844913] 'compare' (duration: 65.004411ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:26:53.78004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.601787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7613"} {"level":"info","ts":"2026-04-08T06:26:53.780231Z","caller":"traceutil/trace.go:171","msg":"trace[1857781030] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5387; }","duration":"160.793943ms","start":"2026-04-08T06:26:53.61937Z","end":"2026-04-08T06:26:53.780164Z","steps":["trace[1857781030] 'agreement among raft nodes before linearized reading' (duration: 160.548787ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:53.949565Z","caller":"traceutil/trace.go:171","msg":"trace[1013734507] transaction","detail":"{read_only:false; response_revision:5388; number_of_response:1; }","duration":"194.776343ms","start":"2026-04-08T06:26:53.754756Z","end":"2026-04-08T06:26:53.949532Z","steps":["trace[1013734507] 'process raft request' (duration: 194.619279ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:53.949556Z","caller":"traceutil/trace.go:171","msg":"trace[681109976] linearizableReadLoop","detail":"{readStateIndex:5592; appliedIndex:5591; }","duration":"169.504792ms","start":"2026-04-08T06:26:53.78Z","end":"2026-04-08T06:26:53.949505Z","steps":["trace[681109976] 'read index received' (duration: 169.308578ms)","trace[681109976] 'applied index is now lower than readState.Index' (duration: 195.254µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:26:53.94985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.281285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-08T06:26:53.949936Z","caller":"traceutil/trace.go:171","msg":"trace[1768510536] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5388; }","duration":"282.47315ms","start":"2026-04-08T06:26:53.667447Z","end":"2026-04-08T06:26:53.94992Z","steps":["trace[1768510536] 'agreement among raft nodes before linearized reading' (duration: 282.175193ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:28:08.389743Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2968} {"level":"info","ts":"2026-04-08T06:28:08.45418Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2968,"took":"63.151368ms","hash":4186779573,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":33751040,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-08T06:28:08.454232Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4186779573,"revision":2968,"compact-revision":-1} {"level":"info","ts":"2026-04-08T06:33:01.254569Z","caller":"traceutil/trace.go:171","msg":"trace[549103719] linearizableReadLoop","detail":"{readStateIndex:8520; appliedIndex:8519; }","duration":"171.562406ms","start":"2026-04-08T06:33:01.08298Z","end":"2026-04-08T06:33:01.254543Z","steps":["trace[549103719] 'read index received' (duration: 171.416012ms)","trace[549103719] 'applied index is now lower than readState.Index' (duration: 145.444µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:33:01.254729Z","caller":"traceutil/trace.go:171","msg":"trace[1544886980] transaction","detail":"{read_only:false; response_revision:8229; number_of_response:1; }","duration":"210.384517ms","start":"2026-04-08T06:33:01.044313Z","end":"2026-04-08T06:33:01.254698Z","steps":["trace[1544886980] 'process raft request' (duration: 210.0658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:01.254782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.788071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jbbj5\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-08T06:33:01.25482Z","caller":"traceutil/trace.go:171","msg":"trace[840481602] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jbbj5; range_end:; response_count:1; response_revision:8229; }","duration":"171.878633ms","start":"2026-04-08T06:33:01.082931Z","end":"2026-04-08T06:33:01.25481Z","steps":["trace[840481602] 'agreement among raft nodes before linearized reading' (duration: 171.714929ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:08.39663Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6073} {"level":"info","ts":"2026-04-08T06:33:08.498464Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6073,"took":"99.972669ms","hash":2913223119,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":23318528,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-08T06:33:08.498728Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2913223119,"revision":6073,"compact-revision":2968} {"level":"warn","ts":"2026-04-08T06:33:12.667178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.554741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-08T06:33:12.667273Z","caller":"traceutil/trace.go:171","msg":"trace[1581162430] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8288; }","duration":"190.704475ms","start":"2026-04-08T06:33:12.476548Z","end":"2026-04-08T06:33:12.667253Z","steps":["trace[1581162430] 'range keys from in-memory index tree' (duration: 190.366897ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:12.728168Z","caller":"traceutil/trace.go:171","msg":"trace[1848752734] transaction","detail":"{read_only:false; response_revision:8289; number_of_response:1; }","duration":"199.67032ms","start":"2026-04-08T06:33:12.528472Z","end":"2026-04-08T06:33:12.728143Z","steps":["trace[1848752734] 'process raft request' (duration: 199.524487ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:12.735597Z","caller":"traceutil/trace.go:171","msg":"trace[746292093] linearizableReadLoop","detail":"{readStateIndex:8586; appliedIndex:8584; }","duration":"156.32543ms","start":"2026-04-08T06:33:12.579244Z","end":"2026-04-08T06:33:12.735569Z","steps":["trace[746292093] 'read index received' (duration: 148.773519ms)","trace[746292093] 'applied index is now lower than readState.Index' (duration: 7.550501ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:33:12.735653Z","caller":"traceutil/trace.go:171","msg":"trace[1305400631] transaction","detail":"{read_only:false; response_revision:8290; number_of_response:1; }","duration":"206.388252ms","start":"2026-04-08T06:33:12.529234Z","end":"2026-04-08T06:33:12.735623Z","steps":["trace[1305400631] 'process raft request' (duration: 206.123305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:12.735757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.496354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:33:12.735822Z","caller":"traceutil/trace.go:171","msg":"trace[529405023] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:8291; }","duration":"156.600497ms","start":"2026-04-08T06:33:12.579194Z","end":"2026-04-08T06:33:12.735794Z","steps":["trace[529405023] 'agreement among raft nodes before linearized reading' (duration: 156.508535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:12.735923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.514637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-08T06:33:12.735931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.925505ms","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-04-08T06:33:12.735988Z","caller":"traceutil/trace.go:171","msg":"trace[560948482] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8291; }","duration":"119.650171ms","start":"2026-04-08T06:33:12.616322Z","end":"2026-04-08T06:33:12.735972Z","steps":["trace[560948482] 'agreement among raft nodes before linearized reading' (duration: 119.442236ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:12.735997Z","caller":"traceutil/trace.go:171","msg":"trace[207880667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8291; }","duration":"112.039788ms","start":"2026-04-08T06:33:12.623941Z","end":"2026-04-08T06:33:12.735981Z","steps":["trace[207880667] 'agreement among raft nodes before linearized reading' (duration: 111.854214ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:14.502161Z","caller":"traceutil/trace.go:171","msg":"trace[737535664] transaction","detail":"{read_only:false; response_revision:8297; number_of_response:1; }","duration":"118.864971ms","start":"2026-04-08T06:33:14.383262Z","end":"2026-04-08T06:33:14.502127Z","steps":["trace[737535664] 'process raft request' (duration: 118.698487ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:41.686939Z","caller":"traceutil/trace.go:171","msg":"trace[425695036] linearizableReadLoop","detail":"{readStateIndex:8803; appliedIndex:8802; }","duration":"199.259571ms","start":"2026-04-08T06:33:41.487662Z","end":"2026-04-08T06:33:41.686921Z","steps":["trace[425695036] 'read index received' (duration: 199.122867ms)","trace[425695036] 'applied index is now lower than readState.Index' (duration: 136.104µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:33:41.687175Z","caller":"traceutil/trace.go:171","msg":"trace[1998734480] transaction","detail":"{read_only:false; response_revision:8499; number_of_response:1; }","duration":"213.219685ms","start":"2026-04-08T06:33:41.473947Z","end":"2026-04-08T06:33:41.687167Z","steps":["trace[1998734480] 'process raft request' (duration: 212.877107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:41.687317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.638169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:33:41.687337Z","caller":"traceutil/trace.go:171","msg":"trace[1437443939] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:8499; }","duration":"199.70115ms","start":"2026-04-08T06:33:41.487629Z","end":"2026-04-08T06:33:41.68733Z","steps":["trace[1437443939] 'agreement among raft nodes before linearized reading' (duration: 199.650469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:41.687472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.589464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jbbj5\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-08T06:33:41.687486Z","caller":"traceutil/trace.go:171","msg":"trace[344499790] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jbbj5; range_end:; response_count:1; response_revision:8499; }","duration":"128.629605ms","start":"2026-04-08T06:33:41.558851Z","end":"2026-04-08T06:33:41.687481Z","steps":["trace[344499790] 'agreement among raft nodes before linearized reading' (duration: 128.563833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:41.687692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.010852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T06:33:41.687712Z","caller":"traceutil/trace.go:171","msg":"trace[198438101] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:8499; }","duration":"123.074513ms","start":"2026-04-08T06:33:41.564632Z","end":"2026-04-08T06:33:41.687706Z","steps":["trace[198438101] 'agreement among raft nodes before linearized reading' (duration: 123.039792ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:41.903757Z","caller":"traceutil/trace.go:171","msg":"trace[1510850454] transaction","detail":"{read_only:false; response_revision:8500; number_of_response:1; }","duration":"125.978113ms","start":"2026-04-08T06:33:41.777746Z","end":"2026-04-08T06:33:41.903724Z","steps":["trace[1510850454] 'process raft request' (duration: 125.798378ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:54.228509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.870278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-lnbmv\" ","response":"range_response_count:1 size:4647"} {"level":"info","ts":"2026-04-08T06:33:54.228622Z","caller":"traceutil/trace.go:171","msg":"trace[1618928381] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-lnbmv; range_end:; response_count:1; response_revision:8603; }","duration":"279.000861ms","start":"2026-04-08T06:33:53.949595Z","end":"2026-04-08T06:33:54.228595Z","steps":["trace[1618928381] 'range keys from in-memory index tree' (duration: 278.758696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:54.228773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.866021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:33:54.228994Z","caller":"traceutil/trace.go:171","msg":"trace[744485862] linearizableReadLoop","detail":"{readStateIndex:8914; appliedIndex:8912; }","duration":"181.298508ms","start":"2026-04-08T06:33:54.047679Z","end":"2026-04-08T06:33:54.228978Z","steps":["trace[744485862] 'read index received' (duration: 83.79101ms)","trace[744485862] 'applied index is now lower than readState.Index' (duration: 97.506668ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:33:54.229102Z","caller":"traceutil/trace.go:171","msg":"trace[730300871] transaction","detail":"{read_only:false; response_revision:8604; number_of_response:1; }","duration":"277.772572ms","start":"2026-04-08T06:33:53.951294Z","end":"2026-04-08T06:33:54.229067Z","steps":["trace[730300871] 'process raft request' (duration: 30.535032ms)","trace[730300871] 'compare' (duration: 246.661997ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:33:54.229164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.476002ms","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-04-08T06:33:54.229195Z","caller":"traceutil/trace.go:171","msg":"trace[504252935] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8605; }","duration":"181.515653ms","start":"2026-04-08T06:33:54.04767Z","end":"2026-04-08T06:33:54.229186Z","steps":["trace[504252935] 'agreement among raft nodes before linearized reading' (duration: 181.362839ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:54.22923Z","caller":"traceutil/trace.go:171","msg":"trace[1564483619] transaction","detail":"{read_only:false; response_revision:8605; number_of_response:1; }","duration":"262.558997ms","start":"2026-04-08T06:33:53.966635Z","end":"2026-04-08T06:33:54.229194Z","steps":["trace[1564483619] 'process raft request' (duration: 262.24444ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:54.85063Z","caller":"traceutil/trace.go:171","msg":"trace[190925687] transaction","detail":"{read_only:false; response_revision:8608; number_of_response:1; }","duration":"132.859956ms","start":"2026-04-08T06:33:54.717736Z","end":"2026-04-08T06:33:54.850596Z","steps":["trace[190925687] 'process raft request' (duration: 132.62595ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:54.930691Z","caller":"traceutil/trace.go:171","msg":"trace[570954798] linearizableReadLoop","detail":"{readStateIndex:8918; appliedIndex:8916; }","duration":"209.899835ms","start":"2026-04-08T06:33:54.720768Z","end":"2026-04-08T06:33:54.930667Z","steps":["trace[570954798] 'read index received' (duration: 129.67923ms)","trace[570954798] 'applied index is now lower than readState.Index' (duration: 80.219575ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:33:54.930829Z","caller":"traceutil/trace.go:171","msg":"trace[1444780230] transaction","detail":"{read_only:false; response_revision:8609; number_of_response:1; }","duration":"210.705054ms","start":"2026-04-08T06:33:54.720102Z","end":"2026-04-08T06:33:54.930807Z","steps":["trace[1444780230] 'process raft request' (duration: 210.387326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:54.930927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.13231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T06:33:54.93097Z","caller":"traceutil/trace.go:171","msg":"trace[147361603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8609; }","duration":"210.210281ms","start":"2026-04-08T06:33:54.720749Z","end":"2026-04-08T06:33:54.930959Z","steps":["trace[147361603] 'agreement among raft nodes before linearized reading' (duration: 210.048658ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:34:35.958437Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002453.wal"} {"level":"info","ts":"2026-04-08T06:35:13.430651Z","caller":"traceutil/trace.go:171","msg":"trace[575450068] transaction","detail":"{read_only:false; response_revision:9367; number_of_response:1; }","duration":"103.502361ms","start":"2026-04-08T06:35:13.327118Z","end":"2026-04-08T06:35:13.43062Z","steps":["trace[575450068] 'process raft request' (duration: 103.255585ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:35:52.146431Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"fe334179879fd0aa","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T06:35:52.155289Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T06:35:52.155449Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T06:38:08.402392Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8267} {"level":"info","ts":"2026-04-08T06:38:08.479214Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8267,"took":"74.668728ms","hash":3616465854,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":24879104,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-08T06:38:08.479286Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3616465854,"revision":8267,"compact-revision":6073} {"level":"info","ts":"2026-04-08T06:43:08.409246Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10664} {"level":"info","ts":"2026-04-08T06:43:08.490748Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10664,"took":"79.885849ms","hash":510282961,"current-db-size-bytes":58015744,"current-db-size":"58 MB","current-db-size-in-use-bytes":20549632,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-08T06:43:08.490806Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":510282961,"revision":10664,"compact-revision":8267}