{"level":"warn","ts":"2026-05-26T05:46:06.944911Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T05:46:06.944991Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-26T05:46:06.945054Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T05:46:06.945085Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-26T05:46:06.945102Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-26T05:46:06.945668Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-05-26T05:46:06.945737Z","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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-26T05:46:06.948058Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.124793ms"} {"level":"info","ts":"2026-05-26T05:46:06.952082Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-05-26T05:46:06.952149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T05:46:06.952166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-05-26T05:46:06.952179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T05:46:06.952188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-05-26T05:46:06.952229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-05-26T05:46:06.962244Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T05:46:06.96439Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T05:46:06.965671Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-26T05:46:06.968451Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T05:46:06.968634Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T05:46:06.968724Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-26T05:46:06.968768Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-26T05:46:06.968776Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-26T05:46:06.969612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-05-26T05:46:06.969769Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-26T05:46:06.974472Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-26T05:46:06.974687Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-26T05:46:06.974819Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-26T05:46:06.975892Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T05:46:06.975839Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T05:46:07.652633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T05:46:07.652706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T05:46:07.65275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-05-26T05:46:07.652769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-05-26T05:46:07.652781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-26T05:46:07.652797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-05-26T05:46:07.652812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-26T05:46:07.654389Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T05:46:07.654431Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T05:46:07.654437Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T05:46:07.654534Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:46:07.654597Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T05:46:07.654694Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T05:46:07.65589Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:46:07.656054Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:46:07.656085Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:46:07.657598Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T05:46:07.657764Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"warn","ts":"2026-05-26T05:46:49.514074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.952624ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:46:49.514184Z","caller":"traceutil/trace.go:171","msg":"trace[1257566172] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"133.442811ms","start":"2026-05-26T05:46:49.380712Z","end":"2026-05-26T05:46:49.514155Z","steps":["trace[1257566172] 'process raft request' (duration: 130.669015ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:46:49.514259Z","caller":"traceutil/trace.go:171","msg":"trace[1505076941] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:586; }","duration":"104.153548ms","start":"2026-05-26T05:46:49.410081Z","end":"2026-05-26T05:46:49.514235Z","steps":["trace[1505076941] 'range keys from in-memory index tree' (duration: 103.934373ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:46:49.574232Z","caller":"traceutil/trace.go:171","msg":"trace[1024668292] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"191.855354ms","start":"2026-05-26T05:46:49.381581Z","end":"2026-05-26T05:46:49.573436Z","steps":["trace[1024668292] 'process raft request' (duration: 191.280692ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:46:49.577568Z","caller":"traceutil/trace.go:171","msg":"trace[371617116] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"158.006138ms","start":"2026-05-26T05:46:49.419506Z","end":"2026-05-26T05:46:49.577512Z","steps":["trace[371617116] 'process raft request' (duration: 153.821413ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:46:49.925594Z","caller":"traceutil/trace.go:171","msg":"trace[903410509] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"284.829545ms","start":"2026-05-26T05:46:49.640712Z","end":"2026-05-26T05:46:49.925541Z","steps":["trace[903410509] 'process raft request' (duration: 269.869501ms)","trace[903410509] 'compare' (duration: 14.585046ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:46:50.076189Z","caller":"traceutil/trace.go:171","msg":"trace[1113580946] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"138.89689ms","start":"2026-05-26T05:46:49.93727Z","end":"2026-05-26T05:46:50.076167Z","steps":["trace[1113580946] 'read index received' (duration: 110.654159ms)","trace[1113580946] 'applied index is now lower than readState.Index' (duration: 28.241711ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:46:50.076261Z","caller":"traceutil/trace.go:171","msg":"trace[1212725633] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"146.413573ms","start":"2026-05-26T05:46:49.929789Z","end":"2026-05-26T05:46:50.076202Z","steps":["trace[1212725633] 'process raft request' (duration: 118.12123ms)","trace[1212725633] 'compare' (duration: 28.084869ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:46:50.076512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.066724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:46:50.076531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.501951ms","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-05-26T05:46:50.076628Z","caller":"traceutil/trace.go:171","msg":"trace[1430885314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:592; }","duration":"129.659255ms","start":"2026-05-26T05:46:49.946943Z","end":"2026-05-26T05:46:50.076602Z","steps":["trace[1430885314] 'agreement among raft nodes before linearized reading' (duration: 129.42403ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:46:50.076821Z","caller":"traceutil/trace.go:171","msg":"trace[1376607533] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:592; }","duration":"139.34523ms","start":"2026-05-26T05:46:49.937241Z","end":"2026-05-26T05:46:50.076586Z","steps":["trace[1376607533] 'agreement among raft nodes before linearized reading' (duration: 139.069504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:21.877457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.451763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a8577e2f-bc6d-4934-9d6c-c6fbf8bf559c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-26T05:48:21.877583Z","caller":"traceutil/trace.go:171","msg":"trace[186934801] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a8577e2f-bc6d-4934-9d6c-c6fbf8bf559c; range_end:; response_count:1; response_revision:1823; }","duration":"164.622955ms","start":"2026-05-26T05:48:21.712936Z","end":"2026-05-26T05:48:21.877559Z","steps":["trace[186934801] 'range keys from in-memory index tree' (duration: 164.310719ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:22.263124Z","caller":"traceutil/trace.go:171","msg":"trace[601803588] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"232.074217ms","start":"2026-05-26T05:48:22.031019Z","end":"2026-05-26T05:48:22.263094Z","steps":["trace[601803588] 'process raft request' (duration: 185.046662ms)","trace[601803588] 'compare' (duration: 46.847271ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:48:22.26376Z","caller":"traceutil/trace.go:171","msg":"trace[1227415601] linearizableReadLoop","detail":"{readStateIndex:1900; appliedIndex:1896; }","duration":"223.634349ms","start":"2026-05-26T05:48:22.040084Z","end":"2026-05-26T05:48:22.263719Z","steps":["trace[1227415601] 'read index received' (duration: 45.302861ms)","trace[1227415601] 'applied index is now lower than readState.Index' (duration: 178.323788ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:48:22.263794Z","caller":"traceutil/trace.go:171","msg":"trace[1208135306] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"232.405554ms","start":"2026-05-26T05:48:22.031347Z","end":"2026-05-26T05:48:22.263752Z","steps":["trace[1208135306] 'process raft request' (duration: 231.701959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:22.264101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.003607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-26T05:48:22.264139Z","caller":"traceutil/trace.go:171","msg":"trace[1370520893] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1831; }","duration":"224.090728ms","start":"2026-05-26T05:48:22.040036Z","end":"2026-05-26T05:48:22.264127Z","steps":["trace[1370520893] 'agreement among raft nodes before linearized reading' (duration: 223.866874ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:22.264152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.570251ms","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-05-26T05:48:22.264565Z","caller":"traceutil/trace.go:171","msg":"trace[350355247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1831; }","duration":"204.07995ms","start":"2026-05-26T05:48:22.06046Z","end":"2026-05-26T05:48:22.26454Z","steps":["trace[350355247] 'agreement among raft nodes before linearized reading' (duration: 203.485169ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:22.264843Z","caller":"traceutil/trace.go:171","msg":"trace[107321619] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"232.506065ms","start":"2026-05-26T05:48:22.031375Z","end":"2026-05-26T05:48:22.263881Z","steps":["trace[107321619] 'process raft request' (duration: 231.867992ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:01.048021Z","caller":"traceutil/trace.go:171","msg":"trace[686083515] linearizableReadLoop","detail":"{readStateIndex:2686; appliedIndex:2685; }","duration":"123.653569ms","start":"2026-05-26T05:50:00.924344Z","end":"2026-05-26T05:50:01.047998Z","steps":["trace[686083515] 'read index received' (duration: 123.533786ms)","trace[686083515] 'applied index is now lower than readState.Index' (duration: 118.563µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:50:01.048096Z","caller":"traceutil/trace.go:171","msg":"trace[1124241751] transaction","detail":"{read_only:false; response_revision:2589; number_of_response:1; }","duration":"189.685489ms","start":"2026-05-26T05:50:00.858381Z","end":"2026-05-26T05:50:01.048067Z","steps":["trace[1124241751] 'process raft request' (duration: 189.479825ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:01.048294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.928715ms","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-05-26T05:50:01.048366Z","caller":"traceutil/trace.go:171","msg":"trace[1367138397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2589; }","duration":"124.059157ms","start":"2026-05-26T05:50:00.924292Z","end":"2026-05-26T05:50:01.048351Z","steps":["trace[1367138397] 'agreement among raft nodes before linearized reading' (duration: 123.857273ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:01.049739Z","caller":"traceutil/trace.go:171","msg":"trace[1200296236] transaction","detail":"{read_only:false; response_revision:2590; number_of_response:1; }","duration":"123.885612ms","start":"2026-05-26T05:50:00.925815Z","end":"2026-05-26T05:50:01.049701Z","steps":["trace[1200296236] 'process raft request' (duration: 123.602027ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:01.049842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.799191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-26T05:50:01.049958Z","caller":"traceutil/trace.go:171","msg":"trace[425702800] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2590; }","duration":"122.943265ms","start":"2026-05-26T05:50:00.926989Z","end":"2026-05-26T05:50:01.049932Z","steps":["trace[425702800] 'agreement among raft nodes before linearized reading' (duration: 122.655029ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:59.909006Z","caller":"traceutil/trace.go:171","msg":"trace[1147063184] transaction","detail":"{read_only:false; response_revision:3756; number_of_response:1; }","duration":"155.892351ms","start":"2026-05-26T05:52:59.753091Z","end":"2026-05-26T05:52:59.908983Z","steps":["trace[1147063184] 'process raft request' (duration: 155.769839ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:59.927349Z","caller":"traceutil/trace.go:171","msg":"trace[1103194446] transaction","detail":"{read_only:false; response_revision:3757; number_of_response:1; }","duration":"115.225725ms","start":"2026-05-26T05:52:59.812104Z","end":"2026-05-26T05:52:59.92733Z","steps":["trace[1103194446] 'process raft request' (duration: 115.118713ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:54:40.675252Z","caller":"traceutil/trace.go:171","msg":"trace[896981341] linearizableReadLoop","detail":"{readStateIndex:5418; appliedIndex:5416; }","duration":"276.335584ms","start":"2026-05-26T05:54:40.398889Z","end":"2026-05-26T05:54:40.675225Z","steps":["trace[896981341] 'read index received' (duration: 209.322428ms)","trace[896981341] 'applied index is now lower than readState.Index' (duration: 67.011646ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:54:40.675395Z","caller":"traceutil/trace.go:171","msg":"trace[723448547] transaction","detail":"{read_only:false; response_revision:5221; number_of_response:1; }","duration":"285.9039ms","start":"2026-05-26T05:54:40.38948Z","end":"2026-05-26T05:54:40.675384Z","steps":["trace[723448547] 'process raft request' (duration: 285.699846ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:54:40.675399Z","caller":"traceutil/trace.go:171","msg":"trace[1576000399] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"287.476553ms","start":"2026-05-26T05:54:40.38789Z","end":"2026-05-26T05:54:40.675366Z","steps":["trace[1576000399] 'process raft request' (duration: 220.333414ms)","trace[1576000399] 'compare' (duration: 66.474164ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:54:40.675754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.845285ms","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-05-26T05:54:40.675802Z","caller":"traceutil/trace.go:171","msg":"trace[1464321201] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5221; }","duration":"276.921536ms","start":"2026-05-26T05:54:40.39887Z","end":"2026-05-26T05:54:40.675791Z","steps":["trace[1464321201] 'agreement among raft nodes before linearized reading' (duration: 276.759133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:54:40.676021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.687038ms","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-05-26T05:54:40.676077Z","caller":"traceutil/trace.go:171","msg":"trace[913047843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5221; }","duration":"272.76445ms","start":"2026-05-26T05:54:40.403299Z","end":"2026-05-26T05:54:40.676064Z","steps":["trace[913047843] 'agreement among raft nodes before linearized reading' (duration: 272.599156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:54:40.676311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.057162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9nc2t\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-05-26T05:54:40.676351Z","caller":"traceutil/trace.go:171","msg":"trace[1088269761] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9nc2t; range_end:; response_count:1; response_revision:5221; }","duration":"135.127904ms","start":"2026-05-26T05:54:40.541212Z","end":"2026-05-26T05:54:40.67634Z","steps":["trace[1088269761] 'agreement among raft nodes before linearized reading' (duration: 135.007212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:54:40.67653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.932125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-26T05:54:40.676565Z","caller":"traceutil/trace.go:171","msg":"trace[1639654733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5221; }","duration":"239.002857ms","start":"2026-05-26T05:54:40.437554Z","end":"2026-05-26T05:54:40.676557Z","steps":["trace[1639654733] 'agreement among raft nodes before linearized reading' (duration: 238.916365ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:54:59.182785Z","caller":"traceutil/trace.go:171","msg":"trace[930072469] transaction","detail":"{read_only:false; response_revision:5541; number_of_response:1; }","duration":"135.134505ms","start":"2026-05-26T05:54:59.047613Z","end":"2026-05-26T05:54:59.182747Z","steps":["trace[930072469] 'process raft request' (duration: 114.589813ms)","trace[930072469] 'compare' (duration: 20.262396ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:54:59.182941Z","caller":"traceutil/trace.go:171","msg":"trace[1248789165] transaction","detail":"{read_only:false; response_revision:5542; number_of_response:1; }","duration":"135.157915ms","start":"2026-05-26T05:54:59.047754Z","end":"2026-05-26T05:54:59.182912Z","steps":["trace[1248789165] 'process raft request' (duration: 134.91179ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:54:59.183209Z","caller":"traceutil/trace.go:171","msg":"trace[1941935475] transaction","detail":"{read_only:false; response_revision:5543; number_of_response:1; }","duration":"135.41238ms","start":"2026-05-26T05:54:59.047784Z","end":"2026-05-26T05:54:59.183196Z","steps":["trace[1941935475] 'process raft request' (duration: 135.077753ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:54:59.183867Z","caller":"traceutil/trace.go:171","msg":"trace[2070650245] transaction","detail":"{read_only:false; response_revision:5544; number_of_response:1; }","duration":"135.916561ms","start":"2026-05-26T05:54:59.047898Z","end":"2026-05-26T05:54:59.183814Z","steps":["trace[2070650245] 'process raft request' (duration: 135.149265ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:07.684694Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2978} {"level":"info","ts":"2026-05-26T05:56:07.756318Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2978,"took":"70.172515ms","hash":3165221422,"current-db-size-bytes":58667008,"current-db-size":"59 MB","current-db-size-in-use-bytes":34091008,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-26T05:56:07.756397Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3165221422,"revision":2978,"compact-revision":-1} {"level":"info","ts":"2026-05-26T06:00:52.686835Z","caller":"traceutil/trace.go:171","msg":"trace[1283360806] linearizableReadLoop","detail":"{readStateIndex:8497; appliedIndex:8496; }","duration":"159.665752ms","start":"2026-05-26T06:00:52.527137Z","end":"2026-05-26T06:00:52.686802Z","steps":["trace[1283360806] 'read index received' (duration: 159.607941ms)","trace[1283360806] 'applied index is now lower than readState.Index' (duration: 56.321µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:00:52.687067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.918968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-26T06:00:52.686965Z","caller":"traceutil/trace.go:171","msg":"trace[1832996999] transaction","detail":"{read_only:false; response_revision:8207; number_of_response:1; }","duration":"249.526033ms","start":"2026-05-26T06:00:52.437368Z","end":"2026-05-26T06:00:52.686894Z","steps":["trace[1832996999] 'process raft request' (duration: 249.268728ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:52.687118Z","caller":"traceutil/trace.go:171","msg":"trace[254646193] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8207; }","duration":"160.024879ms","start":"2026-05-26T06:00:52.527077Z","end":"2026-05-26T06:00:52.687102Z","steps":["trace[254646193] 'agreement among raft nodes before linearized reading' (duration: 159.846965ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:52.878463Z","caller":"traceutil/trace.go:171","msg":"trace[1312904435] linearizableReadLoop","detail":"{readStateIndex:8498; appliedIndex:8497; }","duration":"153.000156ms","start":"2026-05-26T06:00:52.725437Z","end":"2026-05-26T06:00:52.878437Z","steps":["trace[1312904435] 'read index received' (duration: 70.621949ms)","trace[1312904435] 'applied index is now lower than readState.Index' (duration: 82.377167ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:00:52.87858Z","caller":"traceutil/trace.go:171","msg":"trace[248638372] transaction","detail":"{read_only:false; response_revision:8208; number_of_response:1; }","duration":"187.089371ms","start":"2026-05-26T06:00:52.691436Z","end":"2026-05-26T06:00:52.878526Z","steps":["trace[248638372] 'process raft request' (duration: 104.674812ms)","trace[248638372] 'compare' (duration: 82.193233ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:00:52.878724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.207871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-26T06:00:52.878715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.266232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-26T06:00:52.878763Z","caller":"traceutil/trace.go:171","msg":"trace[794130156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8208; }","duration":"153.326163ms","start":"2026-05-26T06:00:52.725427Z","end":"2026-05-26T06:00:52.878753Z","steps":["trace[794130156] 'agreement among raft nodes before linearized reading' (duration: 153.15802ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:52.878791Z","caller":"traceutil/trace.go:171","msg":"trace[732656971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8208; }","duration":"153.412265ms","start":"2026-05-26T06:00:52.72536Z","end":"2026-05-26T06:00:52.878772Z","steps":["trace[732656971] 'agreement among raft nodes before linearized reading' (duration: 153.17458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:52.878835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.226414ms","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-05-26T06:00:52.878891Z","caller":"traceutil/trace.go:171","msg":"trace[846171475] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8208; }","duration":"132.315856ms","start":"2026-05-26T06:00:52.746561Z","end":"2026-05-26T06:00:52.878877Z","steps":["trace[846171475] 'agreement among raft nodes before linearized reading' (duration: 132.167733ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:01:03.856502Z","caller":"traceutil/trace.go:171","msg":"trace[1455693538] transaction","detail":"{read_only:false; response_revision:8268; number_of_response:1; }","duration":"118.234378ms","start":"2026-05-26T06:01:03.738242Z","end":"2026-05-26T06:01:03.856477Z","steps":["trace[1455693538] 'process raft request' (duration: 118.100686ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:01:03.957851Z","caller":"traceutil/trace.go:171","msg":"trace[2112275764] transaction","detail":"{read_only:false; response_revision:8270; number_of_response:1; }","duration":"119.111296ms","start":"2026-05-26T06:01:03.838715Z","end":"2026-05-26T06:01:03.957826Z","steps":["trace[2112275764] 'process raft request' (duration: 119.063665ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:01:03.957883Z","caller":"traceutil/trace.go:171","msg":"trace[475123657] transaction","detail":"{read_only:false; response_revision:8269; number_of_response:1; }","duration":"120.384711ms","start":"2026-05-26T06:01:03.837464Z","end":"2026-05-26T06:01:03.957848Z","steps":["trace[475123657] 'process raft request' (duration: 114.88059ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:01:04.966324Z","caller":"traceutil/trace.go:171","msg":"trace[2865344] transaction","detail":"{read_only:false; response_revision:8271; number_of_response:1; }","duration":"227.459763ms","start":"2026-05-26T06:01:04.738833Z","end":"2026-05-26T06:01:04.966293Z","steps":["trace[2865344] 'process raft request' (duration: 227.263249ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:01:07.691635Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6120} {"level":"info","ts":"2026-05-26T06:01:07.782741Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6120,"took":"89.108585ms","hash":546396711,"current-db-size-bytes":58667008,"current-db-size":"59 MB","current-db-size-in-use-bytes":23461888,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-05-26T06:01:07.782825Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":546396711,"revision":6120,"compact-revision":2978} {"level":"info","ts":"2026-05-26T06:01:45.405881Z","caller":"traceutil/trace.go:171","msg":"trace[442506860] transaction","detail":"{read_only:false; response_revision:8585; number_of_response:1; }","duration":"110.51248ms","start":"2026-05-26T06:01:45.295344Z","end":"2026-05-26T06:01:45.405856Z","steps":["trace[442506860] 'process raft request' (duration: 72.920824ms)","trace[442506860] 'compare' (duration: 37.044015ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:01:45.406654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.348898ms","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-05-26T06:01:45.406733Z","caller":"traceutil/trace.go:171","msg":"trace[535081005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8586; }","duration":"114.490401ms","start":"2026-05-26T06:01:45.292227Z","end":"2026-05-26T06:01:45.406717Z","steps":["trace[535081005] 'agreement among raft nodes before linearized reading' (duration: 114.277727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:01:45.406878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.817468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-26T06:01:45.406981Z","caller":"traceutil/trace.go:171","msg":"trace[835406862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8586; }","duration":"114.946122ms","start":"2026-05-26T06:01:45.291972Z","end":"2026-05-26T06:01:45.406919Z","steps":["trace[835406862] 'agreement among raft nodes before linearized reading' (duration: 114.686756ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:01:45.78789Z","caller":"traceutil/trace.go:171","msg":"trace[465521703] transaction","detail":"{read_only:false; response_revision:8590; number_of_response:1; }","duration":"103.725113ms","start":"2026-05-26T06:01:45.684145Z","end":"2026-05-26T06:01:45.78787Z","steps":["trace[465521703] 'process raft request' (duration: 103.58945ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:31.179517Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002498.wal"} {"level":"info","ts":"2026-05-26T06:03:46.490848Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"11f26225a5bb9fe3","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-26T06:03:46.49595Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-26T06:03:46.496064Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-26T06:06:07.70008Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8294} {"level":"info","ts":"2026-05-26T06:06:07.772954Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8294,"took":"70.445741ms","hash":795136880,"current-db-size-bytes":58667008,"current-db-size":"59 MB","current-db-size-in-use-bytes":26447872,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-26T06:06:07.773032Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":795136880,"revision":8294,"compact-revision":6120} {"level":"info","ts":"2026-05-26T06:06:37.103736Z","caller":"traceutil/trace.go:171","msg":"trace[897020614] linearizableReadLoop","detail":"{readStateIndex:11511; appliedIndex:11510; }","duration":"231.747024ms","start":"2026-05-26T06:06:36.871962Z","end":"2026-05-26T06:06:37.103709Z","steps":["trace[897020614] 'read index received' (duration: 214.928171ms)","trace[897020614] 'applied index is now lower than readState.Index' (duration: 16.817963ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:06:37.10385Z","caller":"traceutil/trace.go:171","msg":"trace[455019385] transaction","detail":"{read_only:false; response_revision:11131; number_of_response:1; }","duration":"261.562292ms","start":"2026-05-26T06:06:36.842278Z","end":"2026-05-26T06:06:37.10384Z","steps":["trace[455019385] 'process raft request' (duration: 244.594426ms)","trace[455019385] 'compare' (duration: 16.721071ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:06:37.104175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.215974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-26T06:06:37.104212Z","caller":"traceutil/trace.go:171","msg":"trace[385954120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11131; }","duration":"232.338086ms","start":"2026-05-26T06:06:36.871865Z","end":"2026-05-26T06:06:37.104203Z","steps":["trace[385954120] 'agreement among raft nodes before linearized reading' (duration: 232.224654ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:06:37.127813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.854985ms","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-05-26T06:06:37.127918Z","caller":"traceutil/trace.go:171","msg":"trace[46081905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11132; }","duration":"254.991017ms","start":"2026-05-26T06:06:36.872907Z","end":"2026-05-26T06:06:37.127898Z","steps":["trace[46081905] 'agreement among raft nodes before linearized reading' (duration: 254.810143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:06:37.128341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.308988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-05-26T06:06:37.128612Z","caller":"traceutil/trace.go:171","msg":"trace[858257328] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11132; }","duration":"187.488602ms","start":"2026-05-26T06:06:36.940942Z","end":"2026-05-26T06:06:37.12843Z","steps":["trace[858257328] 'agreement among raft nodes before linearized reading' (duration: 186.956511ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:06:37.261232Z","caller":"traceutil/trace.go:171","msg":"trace[1004798525] transaction","detail":"{read_only:false; response_revision:11133; number_of_response:1; }","duration":"153.319935ms","start":"2026-05-26T06:06:37.107886Z","end":"2026-05-26T06:06:37.261206Z","steps":["trace[1004798525] 'process raft request' (duration: 153.07835ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:06:37.261431Z","caller":"traceutil/trace.go:171","msg":"trace[596365416] transaction","detail":"{read_only:false; response_revision:11134; number_of_response:1; }","duration":"140.128176ms","start":"2026-05-26T06:06:37.121262Z","end":"2026-05-26T06:06:37.26139Z","steps":["trace[596365416] 'process raft request' (duration: 139.879581ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:06:37.265484Z","caller":"traceutil/trace.go:171","msg":"trace[456953804] transaction","detail":"{read_only:false; response_revision:11135; number_of_response:1; }","duration":"133.463171ms","start":"2026-05-26T06:06:37.131988Z","end":"2026-05-26T06:06:37.265451Z","steps":["trace[456953804] 'process raft request' (duration: 133.257457ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:06:37.265623Z","caller":"traceutil/trace.go:171","msg":"trace[1654057478] linearizableReadLoop","detail":"{readStateIndex:11515; appliedIndex:11512; }","duration":"133.539563ms","start":"2026-05-26T06:06:37.13206Z","end":"2026-05-26T06:06:37.2656Z","steps":["trace[1654057478] 'read index received' (duration: 128.915168ms)","trace[1654057478] 'applied index is now lower than readState.Index' (duration: 4.622315ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:06:37.265875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.795857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-05-26T06:06:37.265918Z","caller":"traceutil/trace.go:171","msg":"trace[1771574015] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11136; }","duration":"133.89995ms","start":"2026-05-26T06:06:37.132008Z","end":"2026-05-26T06:06:37.265908Z","steps":["trace[1771574015] 'agreement among raft nodes before linearized reading' (duration: 133.709126ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:11:07.708369Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10916} {"level":"info","ts":"2026-05-26T06:11:07.789212Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10916,"took":"77.800453ms","hash":1306381362,"current-db-size-bytes":58667008,"current-db-size":"59 MB","current-db-size-in-use-bytes":27996160,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-26T06:11:07.789301Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1306381362,"revision":10916,"compact-revision":8294} {"level":"info","ts":"2026-05-26T06:12:56.814324Z","caller":"traceutil/trace.go:171","msg":"trace[1897879677] transaction","detail":"{read_only:false; response_revision:13685; number_of_response:1; }","duration":"115.86422ms","start":"2026-05-26T06:12:56.698431Z","end":"2026-05-26T06:12:56.814296Z","steps":["trace[1897879677] 'process raft request' (duration: 115.716877ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:13:12.828854Z","caller":"traceutil/trace.go:171","msg":"trace[1218920556] transaction","detail":"{read_only:false; response_revision:13782; number_of_response:1; }","duration":"294.975034ms","start":"2026-05-26T06:13:12.533849Z","end":"2026-05-26T06:13:12.828824Z","steps":["trace[1218920556] 'process raft request' (duration: 294.817661ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:13:12.882705Z","caller":"traceutil/trace.go:171","msg":"trace[1810702121] transaction","detail":"{read_only:false; response_revision:13783; number_of_response:1; }","duration":"226.900913ms","start":"2026-05-26T06:13:12.655783Z","end":"2026-05-26T06:13:12.882684Z","steps":["trace[1810702121] 'process raft request' (duration: 225.78547ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:13:12.883039Z","caller":"traceutil/trace.go:171","msg":"trace[474937841] transaction","detail":"{read_only:false; response_revision:13784; number_of_response:1; }","duration":"222.687658ms","start":"2026-05-26T06:13:12.660315Z","end":"2026-05-26T06:13:12.883003Z","steps":["trace[474937841] 'process raft request' (duration: 222.314991ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:13:22.152796Z","caller":"traceutil/trace.go:171","msg":"trace[415055369] transaction","detail":"{read_only:false; response_revision:13948; number_of_response:1; }","duration":"143.674124ms","start":"2026-05-26T06:13:22.009098Z","end":"2026-05-26T06:13:22.152772Z","steps":["trace[415055369] 'process raft request' (duration: 142.169823ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:15:01.430063Z","caller":"traceutil/trace.go:171","msg":"trace[1753687940] linearizableReadLoop","detail":"{readStateIndex:15541; appliedIndex:15540; }","duration":"173.948338ms","start":"2026-05-26T06:15:01.256094Z","end":"2026-05-26T06:15:01.430043Z","steps":["trace[1753687940] 'read index received' (duration: 173.729124ms)","trace[1753687940] 'applied index is now lower than readState.Index' (duration: 218.654µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:15:01.430189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.091231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:15:01.43022Z","caller":"traceutil/trace.go:171","msg":"trace[959948694] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:15030; }","duration":"174.190563ms","start":"2026-05-26T06:15:01.256018Z","end":"2026-05-26T06:15:01.430209Z","steps":["trace[959948694] 'agreement among raft nodes before linearized reading' (duration: 174.126512ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:15:01.430246Z","caller":"traceutil/trace.go:171","msg":"trace[1812332180] transaction","detail":"{read_only:false; response_revision:15030; number_of_response:1; }","duration":"227.863675ms","start":"2026-05-26T06:15:01.202321Z","end":"2026-05-26T06:15:01.430185Z","steps":["trace[1812332180] 'process raft request' (duration: 227.565679ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:15:01.459027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.72743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-05-26T06:15:01.45912Z","caller":"traceutil/trace.go:171","msg":"trace[1069922625] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15032; }","duration":"190.843012ms","start":"2026-05-26T06:15:01.268253Z","end":"2026-05-26T06:15:01.459096Z","steps":["trace[1069922625] 'agreement among raft nodes before linearized reading' (duration: 190.590087ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:15:01.45947Z","caller":"traceutil/trace.go:171","msg":"trace[539980308] transaction","detail":"{read_only:false; response_revision:15031; number_of_response:1; }","duration":"186.996263ms","start":"2026-05-26T06:15:01.272461Z","end":"2026-05-26T06:15:01.459458Z","steps":["trace[539980308] 'process raft request' (duration: 186.129086ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:15:01.459612Z","caller":"traceutil/trace.go:171","msg":"trace[2009529761] transaction","detail":"{read_only:false; response_revision:15032; number_of_response:1; }","duration":"181.936201ms","start":"2026-05-26T06:15:01.277667Z","end":"2026-05-26T06:15:01.459603Z","steps":["trace[2009529761] 'process raft request' (duration: 181.121544ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:15:01.673226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.046008ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T06:15:01.673336Z","caller":"traceutil/trace.go:171","msg":"trace[375185062] transaction","detail":"{read_only:false; response_revision:15033; number_of_response:1; }","duration":"206.328498ms","start":"2026-05-26T06:15:01.466989Z","end":"2026-05-26T06:15:01.673317Z","steps":["trace[375185062] 'process raft request' (duration: 94.638476ms)","trace[375185062] 'compare' (duration: 110.710471ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:15:01.677043Z","caller":"traceutil/trace.go:171","msg":"trace[1514892520] linearizableReadLoop","detail":"{readStateIndex:15545; appliedIndex:15543; }","duration":"173.00464ms","start":"2026-05-26T06:15:01.50401Z","end":"2026-05-26T06:15:01.677015Z","steps":["trace[1514892520] 'read index received' (duration: 57.727805ms)","trace[1514892520] 'applied index is now lower than readState.Index' (duration: 115.275255ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:15:01.677172Z","caller":"traceutil/trace.go:171","msg":"trace[338654470] transaction","detail":"{read_only:false; response_revision:15034; number_of_response:1; }","duration":"210.080844ms","start":"2026-05-26T06:15:01.467077Z","end":"2026-05-26T06:15:01.677158Z","steps":["trace[338654470] 'process raft request' (duration: 209.826429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:15:01.67725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.798175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:15:01.677329Z","caller":"traceutil/trace.go:171","msg":"trace[1882788882] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15034; }","duration":"172.885317ms","start":"2026-05-26T06:15:01.504421Z","end":"2026-05-26T06:15:01.677307Z","steps":["trace[1882788882] 'agreement among raft nodes before linearized reading' (duration: 172.790535ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:15:01.677497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.487949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:15:01.677535Z","caller":"traceutil/trace.go:171","msg":"trace[2070054535] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15034; }","duration":"173.578511ms","start":"2026-05-26T06:15:01.503948Z","end":"2026-05-26T06:15:01.677526Z","steps":["trace[2070054535] 'agreement among raft nodes before linearized reading' (duration: 173.5279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:15:01.677641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.578447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"warn","ts":"2026-05-26T06:15:01.677685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.85056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9nc2t\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-05-26T06:15:01.677705Z","caller":"traceutil/trace.go:171","msg":"trace[1560376228] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9nc2t; range_end:; response_count:1; response_revision:15034; }","duration":"154.901981ms","start":"2026-05-26T06:15:01.522797Z","end":"2026-05-26T06:15:01.677699Z","steps":["trace[1560376228] 'agreement among raft nodes before linearized reading' (duration: 154.811969ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:15:01.677703Z","caller":"traceutil/trace.go:171","msg":"trace[1455973465] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15034; }","duration":"103.692019ms","start":"2026-05-26T06:15:01.573992Z","end":"2026-05-26T06:15:01.677684Z","steps":["trace[1455973465] 'agreement among raft nodes before linearized reading' (duration: 103.512156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:15:01.677871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.345435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-05-26T06:15:01.677905Z","caller":"traceutil/trace.go:171","msg":"trace[1055115925] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15034; }","duration":"168.417726ms","start":"2026-05-26T06:15:01.509482Z","end":"2026-05-26T06:15:01.677899Z","steps":["trace[1055115925] 'agreement among raft nodes before linearized reading' (duration: 168.319204ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:15:01.677951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.255555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:15:01.678026Z","caller":"traceutil/trace.go:171","msg":"trace[2058073765] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15034; }","duration":"173.420138ms","start":"2026-05-26T06:15:01.504591Z","end":"2026-05-26T06:15:01.678011Z","steps":["trace[2058073765] 'agreement among raft nodes before linearized reading' (duration: 173.270245ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:15:01.678267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.664438ms","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-05-26T06:15:01.678309Z","caller":"traceutil/trace.go:171","msg":"trace[956751425] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15034; }","duration":"101.725149ms","start":"2026-05-26T06:15:01.576572Z","end":"2026-05-26T06:15:01.678297Z","steps":["trace[956751425] 'agreement among raft nodes before linearized reading' (duration: 101.620787ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:15:01.678317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.736961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:15:01.67836Z","caller":"traceutil/trace.go:171","msg":"trace[531941675] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15034; }","duration":"103.820632ms","start":"2026-05-26T06:15:01.574529Z","end":"2026-05-26T06:15:01.678349Z","steps":["trace[531941675] 'agreement among raft nodes before linearized reading' (duration: 103.75624ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:15:01.92138Z","caller":"traceutil/trace.go:171","msg":"trace[738304951] transaction","detail":"{read_only:false; response_revision:15036; number_of_response:1; }","duration":"162.903154ms","start":"2026-05-26T06:15:01.758448Z","end":"2026-05-26T06:15:01.921351Z","steps":["trace[738304951] 'process raft request' (duration: 162.406784ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:15:01.929177Z","caller":"traceutil/trace.go:171","msg":"trace[515414733] linearizableReadLoop","detail":"{readStateIndex:15548; appliedIndex:15546; }","duration":"137.795983ms","start":"2026-05-26T06:15:01.791361Z","end":"2026-05-26T06:15:01.929157Z","steps":["trace[515414733] 'read index received' (duration: 129.423963ms)","trace[515414733] 'applied index is now lower than readState.Index' (duration: 8.3709ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:15:01.929241Z","caller":"traceutil/trace.go:171","msg":"trace[1964067070] transaction","detail":"{read_only:false; response_revision:15037; number_of_response:1; }","duration":"170.459288ms","start":"2026-05-26T06:15:01.758758Z","end":"2026-05-26T06:15:01.929217Z","steps":["trace[1964067070] 'process raft request' (duration: 170.294285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:15:01.929367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.001447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-05-26T06:15:01.929396Z","caller":"traceutil/trace.go:171","msg":"trace[163072111] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15037; }","duration":"138.061188ms","start":"2026-05-26T06:15:01.791326Z","end":"2026-05-26T06:15:01.929387Z","steps":["trace[163072111] 'agreement among raft nodes before linearized reading' (duration: 137.932345ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:16:07.714611Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12978} {"level":"info","ts":"2026-05-26T06:16:07.791422Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12978,"took":"72.651678ms","hash":2915630211,"current-db-size-bytes":58667008,"current-db-size":"59 MB","current-db-size-in-use-bytes":31035392,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-26T06:16:07.791502Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2915630211,"revision":12978,"compact-revision":10916} {"level":"info","ts":"2026-05-26T06:20:44.669105Z","caller":"traceutil/trace.go:171","msg":"trace[575274845] transaction","detail":"{read_only:false; response_revision:17562; number_of_response:1; }","duration":"161.939528ms","start":"2026-05-26T06:20:44.507142Z","end":"2026-05-26T06:20:44.669081Z","steps":["trace[575274845] 'process raft request' (duration: 161.793485ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:20:44.991614Z","caller":"traceutil/trace.go:171","msg":"trace[1577551027] linearizableReadLoop","detail":"{readStateIndex:18160; appliedIndex:18158; }","duration":"186.745061ms","start":"2026-05-26T06:20:44.80484Z","end":"2026-05-26T06:20:44.991585Z","steps":["trace[1577551027] 'read index received' (duration: 184.995025ms)","trace[1577551027] 'applied index is now lower than readState.Index' (duration: 1.748696ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:20:44.991773Z","caller":"traceutil/trace.go:171","msg":"trace[884009613] transaction","detail":"{read_only:false; response_revision:17564; number_of_response:1; }","duration":"248.738356ms","start":"2026-05-26T06:20:44.742979Z","end":"2026-05-26T06:20:44.991717Z","steps":["trace[884009613] 'process raft request' (duration: 246.851368ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:20:44.991947Z","caller":"traceutil/trace.go:171","msg":"trace[1929002086] transaction","detail":"{read_only:false; response_revision:17565; number_of_response:1; }","duration":"243.604172ms","start":"2026-05-26T06:20:44.74813Z","end":"2026-05-26T06:20:44.991735Z","steps":["trace[1929002086] 'process raft request' (duration: 243.375497ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:20:44.992013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.149058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-05-26T06:20:44.992039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.761138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-05-26T06:20:44.992142Z","caller":"traceutil/trace.go:171","msg":"trace[1632002763] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17565; }","duration":"130.911911ms","start":"2026-05-26T06:20:44.861206Z","end":"2026-05-26T06:20:44.992118Z","steps":["trace[1632002763] 'agreement among raft nodes before linearized reading' (duration: 130.598745ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:20:44.99215Z","caller":"traceutil/trace.go:171","msg":"trace[162290263] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:17565; }","duration":"187.308972ms","start":"2026-05-26T06:20:44.804796Z","end":"2026-05-26T06:20:44.992105Z","steps":["trace[162290263] 'agreement among raft nodes before linearized reading' (duration: 186.967605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:20:45.273218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.902149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-8mg2q\" ","response":"range_response_count:1 size:22094"} {"level":"info","ts":"2026-05-26T06:20:45.273295Z","caller":"traceutil/trace.go:171","msg":"trace[336562478] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-8mg2q; range_end:; response_count:1; response_revision:17565; }","duration":"129.014722ms","start":"2026-05-26T06:20:45.144262Z","end":"2026-05-26T06:20:45.273277Z","steps":["trace[336562478] 'range keys from in-memory index tree' (duration: 128.739946ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:20:45.502343Z","caller":"traceutil/trace.go:171","msg":"trace[1059550133] linearizableReadLoop","detail":"{readStateIndex:18161; appliedIndex:18160; }","duration":"178.167717ms","start":"2026-05-26T06:20:45.324155Z","end":"2026-05-26T06:20:45.502323Z","steps":["trace[1059550133] 'read index received' (duration: 178.007674ms)","trace[1059550133] 'applied index is now lower than readState.Index' (duration: 159.313µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:20:45.502537Z","caller":"traceutil/trace.go:171","msg":"trace[1638861259] transaction","detail":"{read_only:false; response_revision:17566; number_of_response:1; }","duration":"214.34969ms","start":"2026-05-26T06:20:45.288158Z","end":"2026-05-26T06:20:45.502508Z","steps":["trace[1638861259] 'process raft request' (duration: 214.052364ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:20:45.502648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.337926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"warn","ts":"2026-05-26T06:20:45.502704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.482513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-26T06:20:45.502744Z","caller":"traceutil/trace.go:171","msg":"trace[1995213757] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17566; }","duration":"137.549265ms","start":"2026-05-26T06:20:45.365185Z","end":"2026-05-26T06:20:45.502734Z","steps":["trace[1995213757] 'agreement among raft nodes before linearized reading' (duration: 137.412143ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:20:45.502725Z","caller":"traceutil/trace.go:171","msg":"trace[76936733] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17566; }","duration":"163.443909ms","start":"2026-05-26T06:20:45.339267Z","end":"2026-05-26T06:20:45.502711Z","steps":["trace[76936733] 'agreement among raft nodes before linearized reading' (duration: 163.219014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:20:45.502721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.838481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-26T06:20:45.502826Z","caller":"traceutil/trace.go:171","msg":"trace[1323199633] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17566; }","duration":"138.979185ms","start":"2026-05-26T06:20:45.363824Z","end":"2026-05-26T06:20:45.502803Z","steps":["trace[1323199633] 'agreement among raft nodes before linearized reading' (duration: 138.688219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:20:45.503078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.106267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-05-26T06:20:45.503109Z","caller":"traceutil/trace.go:171","msg":"trace[219939795] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:17566; }","duration":"143.160088ms","start":"2026-05-26T06:20:45.35994Z","end":"2026-05-26T06:20:45.5031Z","steps":["trace[219939795] 'agreement among raft nodes before linearized reading' (duration: 142.634487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:20:45.503115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.937803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-26T06:20:45.503218Z","caller":"traceutil/trace.go:171","msg":"trace[856771975] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:17566; }","duration":"179.079726ms","start":"2026-05-26T06:20:45.324086Z","end":"2026-05-26T06:20:45.503166Z","steps":["trace[856771975] 'agreement among raft nodes before linearized reading' (duration: 178.371172ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:21:07.72032Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15467} {"level":"info","ts":"2026-05-26T06:21:07.81789Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15467,"took":"94.306009ms","hash":1193229346,"current-db-size-bytes":58667008,"current-db-size":"59 MB","current-db-size-in-use-bytes":31809536,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-26T06:21:07.817943Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1193229346,"revision":15467,"compact-revision":12978} {"level":"info","ts":"2026-05-26T06:26:07.728849Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17764} {"level":"info","ts":"2026-05-26T06:26:07.825113Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17764,"took":"92.599743ms","hash":3397556196,"current-db-size-bytes":58667008,"current-db-size":"59 MB","current-db-size-in-use-bytes":26738688,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-05-26T06:26:07.82517Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3397556196,"revision":17764,"compact-revision":15467} {"level":"info","ts":"2026-05-26T06:26:08.926429Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"11f26225a5bb9fe3","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-26T06:26:08.93143Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-26T06:26:08.93154Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}