{"level":"warn","ts":"2026-04-26T00:41:04.076523Z","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-26T00:41:04.076615Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.35: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.35:2380","--initial-cluster=instance=https://199.204.45.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.35: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-26T00:41:04.076696Z","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-26T00:41:04.076705Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-04-26T00:41:04.076724Z","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-26T00:41:04.077376Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"]} {"level":"info","ts":"2026-04-26T00:41:04.077448Z","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.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.35: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-26T00:41:04.081502Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.831448ms"} {"level":"info","ts":"2026-04-26T00:41:04.092829Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fb85913747d92cac","cluster-id":"636a84d5a3ba9c31"} {"level":"info","ts":"2026-04-26T00:41:04.092953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=()"} {"level":"info","ts":"2026-04-26T00:41:04.09299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 0"} {"level":"info","ts":"2026-04-26T00:41:04.093009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fb85913747d92cac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-26T00:41:04.093032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 1"} {"level":"info","ts":"2026-04-26T00:41:04.093134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"warn","ts":"2026-04-26T00:41:04.100094Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-26T00:41:04.103551Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-26T00:41:04.105354Z","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-26T00:41:04.108327Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fb85913747d92cac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-26T00:41:04.108485Z","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-26T00:41:04.10854Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fb85913747d92cac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-26T00:41:04.108667Z","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-26T00:41:04.108689Z","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-26T00:41:04.109523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"info","ts":"2026-04-26T00:41:04.109696Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","added-peer-id":"fb85913747d92cac","added-peer-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-04-26T00:41:04.111617Z","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-26T00:41:04.111736Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-04-26T00:41:04.111815Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-04-26T00:41:04.111887Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fb85913747d92cac","initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-26T00:41:04.111933Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-26T00:41:04.994051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac is starting a new election at term 1"} {"level":"info","ts":"2026-04-26T00:41:04.994187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became pre-candidate at term 1"} {"level":"info","ts":"2026-04-26T00:41:04.994291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgPreVoteResp from fb85913747d92cac at term 1"} {"level":"info","ts":"2026-04-26T00:41:04.994374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became candidate at term 2"} {"level":"info","ts":"2026-04-26T00:41:04.994428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgVoteResp from fb85913747d92cac at term 2"} {"level":"info","ts":"2026-04-26T00:41:04.994492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became leader at term 2"} {"level":"info","ts":"2026-04-26T00:41:04.994546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fb85913747d92cac elected leader fb85913747d92cac at term 2"} {"level":"info","ts":"2026-04-26T00:41:04.995642Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fb85913747d92cac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.35:2379]}","request-path":"/0/members/fb85913747d92cac/attributes","cluster-id":"636a84d5a3ba9c31","publish-timeout":"7s"} {"level":"info","ts":"2026-04-26T00:41:04.995648Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-26T00:41:04.995694Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T00:41:04.995716Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-26T00:41:04.996174Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-26T00:41:04.996333Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-26T00:41:04.996831Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T00:41:04.99705Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T00:41:04.997108Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T00:41:04.999297Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-26T00:41:05.005049Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.35:2379"} {"level":"info","ts":"2026-04-26T00:41:36.130722Z","caller":"traceutil/trace.go:171","msg":"trace[551099093] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"142.736954ms","start":"2026-04-26T00:41:35.987932Z","end":"2026-04-26T00:41:36.130669Z","steps":["trace[551099093] 'process raft request' (duration: 141.633427ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:41:36.322687Z","caller":"traceutil/trace.go:171","msg":"trace[324954845] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"120.27301ms","start":"2026-04-26T00:41:36.20238Z","end":"2026-04-26T00:41:36.322653Z","steps":["trace[324954845] 'process raft request' (duration: 90.971593ms)","trace[324954845] 'compare' (duration: 29.148253ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T00:41:36.819097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.295382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-26T00:41:36.819205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.019989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-26T00:41:36.819218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.373771ms","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-26T00:41:36.819255Z","caller":"traceutil/trace.go:171","msg":"trace[610020374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:606; }","duration":"180.106642ms","start":"2026-04-26T00:41:36.639133Z","end":"2026-04-26T00:41:36.81924Z","steps":["trace[610020374] 'range keys from in-memory index tree' (duration: 179.941438ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:41:36.819313Z","caller":"traceutil/trace.go:171","msg":"trace[1792016571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:606; }","duration":"153.510705ms","start":"2026-04-26T00:41:36.665778Z","end":"2026-04-26T00:41:36.819288Z","steps":["trace[1792016571] 'range keys from in-memory index tree' (duration: 153.253718ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:41:36.819438Z","caller":"traceutil/trace.go:171","msg":"trace[1836432291] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:606; }","duration":"226.464146ms","start":"2026-04-26T00:41:36.592737Z","end":"2026-04-26T00:41:36.819201Z","steps":["trace[1836432291] 'range keys from in-memory index tree' (duration: 226.156329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:41:36.819419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.484562ms","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-26T00:41:36.81959Z","caller":"traceutil/trace.go:171","msg":"trace[43545981] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:606; }","duration":"325.737158ms","start":"2026-04-26T00:41:36.49384Z","end":"2026-04-26T00:41:36.819577Z","steps":["trace[43545981] 'range keys from in-memory index tree' (duration: 325.235116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:41:36.823458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T00:41:36.493818Z","time spent":"329.617395ms","remote":"127.0.0.1:36094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-26T00:42:15.371432Z","caller":"traceutil/trace.go:171","msg":"trace[2079627140] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1001; }","duration":"128.928067ms","start":"2026-04-26T00:42:15.242478Z","end":"2026-04-26T00:42:15.371406Z","steps":["trace[2079627140] 'read index received' (duration: 4.722647ms)","trace[2079627140] 'applied index is now lower than readState.Index' (duration: 124.20438ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T00:42:15.371471Z","caller":"traceutil/trace.go:171","msg":"trace[2128125178] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"129.191973ms","start":"2026-04-26T00:42:15.242243Z","end":"2026-04-26T00:42:15.371435Z","steps":["trace[2128125178] 'process raft request' (duration: 128.970548ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:42:15.371601Z","caller":"traceutil/trace.go:171","msg":"trace[1976066050] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"126.742122ms","start":"2026-04-26T00:42:15.244844Z","end":"2026-04-26T00:42:15.371586Z","steps":["trace[1976066050] 'process raft request' (duration: 126.511406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:42:15.371789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.287586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/node-feature-discovery-master-conf\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-26T00:42:15.371833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.007199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/goldpinger-clusterrolebinding\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:42:15.371861Z","caller":"traceutil/trace.go:171","msg":"trace[278387256] range","detail":"{range_begin:/registry/configmaps/monitoring/node-feature-discovery-master-conf; range_end:; response_count:0; response_revision:969; }","duration":"129.399878ms","start":"2026-04-26T00:42:15.242444Z","end":"2026-04-26T00:42:15.371843Z","steps":["trace[278387256] 'agreement among raft nodes before linearized reading' (duration: 129.247025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:42:15.37184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.139612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/ingress-nginx/ingress-nginx\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:42:15.371907Z","caller":"traceutil/trace.go:171","msg":"trace[658902424] range","detail":"{range_begin:/registry/clusterrolebindings/goldpinger-clusterrolebinding; range_end:; response_count:0; response_revision:969; }","duration":"129.105522ms","start":"2026-04-26T00:42:15.242783Z","end":"2026-04-26T00:42:15.371889Z","steps":["trace[658902424] 'agreement among raft nodes before linearized reading' (duration: 128.965058ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:42:15.371975Z","caller":"traceutil/trace.go:171","msg":"trace[518657249] range","detail":"{range_begin:/registry/roles/ingress-nginx/ingress-nginx; range_end:; response_count:0; response_revision:969; }","duration":"129.335777ms","start":"2026-04-26T00:42:15.242612Z","end":"2026-04-26T00:42:15.371947Z","steps":["trace[518657249] 'agreement among raft nodes before linearized reading' (duration: 129.05352ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:42:15.506217Z","caller":"traceutil/trace.go:171","msg":"trace[1521064352] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"127.389249ms","start":"2026-04-26T00:42:15.37879Z","end":"2026-04-26T00:42:15.506179Z","steps":["trace[1521064352] 'process raft request' (duration: 127.086522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:42:15.506298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.466902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/node-feature-discovery-worker-conf\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-26T00:42:15.506343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.781299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/monitoring/goldpinger\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-26T00:42:15.506337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.193586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-7r5bb\" ","response":"range_response_count:1 size:5676"} {"level":"info","ts":"2026-04-26T00:42:15.506392Z","caller":"traceutil/trace.go:171","msg":"trace[953589417] range","detail":"{range_begin:/registry/configmaps/monitoring/node-feature-discovery-worker-conf; range_end:; response_count:0; response_revision:971; }","duration":"127.628195ms","start":"2026-04-26T00:42:15.378739Z","end":"2026-04-26T00:42:15.506368Z","steps":["trace[953589417] 'agreement among raft nodes before linearized reading' (duration: 127.479521ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:42:15.506399Z","caller":"traceutil/trace.go:171","msg":"trace[1972024494] range","detail":"{range_begin:/registry/daemonsets/monitoring/goldpinger; range_end:; response_count:0; response_revision:971; }","duration":"127.85505ms","start":"2026-04-26T00:42:15.378527Z","end":"2026-04-26T00:42:15.506382Z","steps":["trace[1972024494] 'agreement among raft nodes before linearized reading' (duration: 127.774178ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:42:15.506437Z","caller":"traceutil/trace.go:171","msg":"trace[590947036] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-7r5bb; range_end:; response_count:1; response_revision:971; }","duration":"110.35673ms","start":"2026-04-26T00:42:15.396055Z","end":"2026-04-26T00:42:15.506412Z","steps":["trace[590947036] 'agreement among raft nodes before linearized reading' (duration: 110.086743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:42:15.506498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.7065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-26T00:42:15.506537Z","caller":"traceutil/trace.go:171","msg":"trace[743406033] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:971; }","duration":"120.795593ms","start":"2026-04-26T00:42:15.38573Z","end":"2026-04-26T00:42:15.506526Z","steps":["trace[743406033] 'agreement among raft nodes before linearized reading' (duration: 120.65873ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:42:16.757118Z","caller":"traceutil/trace.go:171","msg":"trace[1252279658] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"101.765195ms","start":"2026-04-26T00:42:16.655332Z","end":"2026-04-26T00:42:16.757097Z","steps":["trace[1252279658] 'process raft request' (duration: 101.631291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:42:16.757417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.943554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/rook-ceph/\" range_end:\"/registry/secrets/rook-ceph0\" ","response":"range_response_count:1 size:307175"} {"level":"info","ts":"2026-04-26T00:42:16.757434Z","caller":"traceutil/trace.go:171","msg":"trace[982921656] range","detail":"{range_begin:/registry/secrets/rook-ceph/; range_end:/registry/secrets/rook-ceph0; response_count:1; response_revision:1226; }","duration":"108.995116ms","start":"2026-04-26T00:42:16.648434Z","end":"2026-04-26T00:42:16.757429Z","steps":["trace[982921656] 'agreement among raft nodes before linearized reading' (duration: 108.847142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:42:16.757661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.371464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/cert-manager/cert-manager:leaderelection\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:42:16.757712Z","caller":"traceutil/trace.go:171","msg":"trace[1312894817] range","detail":"{range_begin:/registry/rolebindings/cert-manager/cert-manager:leaderelection; range_end:; response_count:0; response_revision:1226; }","duration":"130.450715ms","start":"2026-04-26T00:42:16.627247Z","end":"2026-04-26T00:42:16.757698Z","steps":["trace[1312894817] 'agreement among raft nodes before linearized reading' (duration: 130.379934ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:42:27.86332Z","caller":"traceutil/trace.go:171","msg":"trace[451461290] transaction","detail":"{read_only:false; response_revision:1489; number_of_response:1; }","duration":"125.466401ms","start":"2026-04-26T00:42:27.737826Z","end":"2026-04-26T00:42:27.863293Z","steps":["trace[451461290] 'process raft request' (duration: 125.348718ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:42:31.545963Z","caller":"traceutil/trace.go:171","msg":"trace[965665100] transaction","detail":"{read_only:false; response_revision:1583; number_of_response:1; }","duration":"105.503747ms","start":"2026-04-26T00:42:31.440437Z","end":"2026-04-26T00:42:31.545941Z","steps":["trace[965665100] 'process raft request' (duration: 105.283192ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:42:31.753683Z","caller":"traceutil/trace.go:171","msg":"trace[57137385] transaction","detail":"{read_only:false; response_revision:1585; number_of_response:1; }","duration":"298.195157ms","start":"2026-04-26T00:42:31.455467Z","end":"2026-04-26T00:42:31.753663Z","steps":["trace[57137385] 'process raft request' (duration: 298.117766ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:42:31.753905Z","caller":"traceutil/trace.go:171","msg":"trace[647230652] transaction","detail":"{read_only:false; response_revision:1584; number_of_response:1; }","duration":"312.065812ms","start":"2026-04-26T00:42:31.441813Z","end":"2026-04-26T00:42:31.753879Z","steps":["trace[647230652] 'process raft request' (duration: 248.781703ms)","trace[647230652] 'compare' (duration: 62.638434ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T00:42:31.754313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T00:42:31.441797Z","time spent":"312.191005ms","remote":"127.0.0.1:35904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":812,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-26T00:42:31.780271Z","caller":"traceutil/trace.go:171","msg":"trace[1985430752] transaction","detail":"{read_only:false; response_revision:1586; number_of_response:1; }","duration":"223.579451ms","start":"2026-04-26T00:42:31.556673Z","end":"2026-04-26T00:42:31.780253Z","steps":["trace[1985430752] 'process raft request' (duration: 223.477269ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:42:32.030334Z","caller":"traceutil/trace.go:171","msg":"trace[1233378708] transaction","detail":"{read_only:false; response_revision:1587; number_of_response:1; }","duration":"262.053135ms","start":"2026-04-26T00:42:31.768241Z","end":"2026-04-26T00:42:32.030295Z","steps":["trace[1233378708] 'process raft request' (duration: 191.385529ms)","trace[1233378708] 'compare' (duration: 70.009571ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T00:42:32.030631Z","caller":"traceutil/trace.go:171","msg":"trace[1319610050] transaction","detail":"{read_only:false; response_revision:1588; number_of_response:1; }","duration":"246.772839ms","start":"2026-04-26T00:42:31.783837Z","end":"2026-04-26T00:42:32.03061Z","steps":["trace[1319610050] 'process raft request' (duration: 246.666255ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:42:41.320591Z","caller":"traceutil/trace.go:171","msg":"trace[1196570348] transaction","detail":"{read_only:false; response_revision:1742; number_of_response:1; }","duration":"100.471963ms","start":"2026-04-26T00:42:41.22008Z","end":"2026-04-26T00:42:41.320552Z","steps":["trace[1196570348] 'process raft request' (duration: 100.194706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:43:26.856626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.619386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:43:26.856758Z","caller":"traceutil/trace.go:171","msg":"trace[1722962849] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2345; }","duration":"107.818671ms","start":"2026-04-26T00:43:26.748918Z","end":"2026-04-26T00:43:26.856737Z","steps":["trace[1722962849] 'range keys from in-memory index tree' (duration: 107.520964ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:45:49.113032Z","caller":"traceutil/trace.go:171","msg":"trace[1879753345] transaction","detail":"{read_only:false; response_revision:3627; number_of_response:1; }","duration":"108.113721ms","start":"2026-04-26T00:45:49.004893Z","end":"2026-04-26T00:45:49.113007Z","steps":["trace[1879753345] 'process raft request' (duration: 107.955377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:46:33.784196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.296246ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-26T00:46:33.784308Z","caller":"traceutil/trace.go:171","msg":"trace[182128980] linearizableReadLoop","detail":"{readStateIndex:4052; appliedIndex:4051; }","duration":"189.585626ms","start":"2026-04-26T00:46:33.594701Z","end":"2026-04-26T00:46:33.784286Z","steps":["trace[182128980] 'read index received' (duration: 52.841µs)","trace[182128980] 'applied index is now lower than readState.Index' (duration: 189.531445ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T00:46:33.78452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.803351ms","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-26T00:46:33.784611Z","caller":"traceutil/trace.go:171","msg":"trace[367857187] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3911; }","duration":"189.935024ms","start":"2026-04-26T00:46:33.594657Z","end":"2026-04-26T00:46:33.784592Z","steps":["trace[367857187] 'agreement among raft nodes before linearized reading' (duration: 189.716059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:47:01.276868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.180125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T00:47:01.277003Z","caller":"traceutil/trace.go:171","msg":"trace[742737930] linearizableReadLoop","detail":"{readStateIndex:4340; appliedIndex:4339; }","duration":"195.165454ms","start":"2026-04-26T00:47:01.081816Z","end":"2026-04-26T00:47:01.276982Z","steps":["trace[742737930] 'read index received' (duration: 57.345965ms)","trace[742737930] 'applied index is now lower than readState.Index' (duration: 137.818168ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T00:47:01.277015Z","caller":"traceutil/trace.go:171","msg":"trace[305809329] transaction","detail":"{read_only:false; response_revision:4194; number_of_response:1; }","duration":"201.760752ms","start":"2026-04-26T00:47:01.07523Z","end":"2026-04-26T00:47:01.276991Z","steps":["trace[305809329] 'process raft request' (duration: 64.009494ms)","trace[305809329] 'compare' (duration: 137.067793ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T00:47:01.277209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.382768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-26T00:47:01.277273Z","caller":"traceutil/trace.go:171","msg":"trace[1011579483] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:4194; }","duration":"195.47735ms","start":"2026-04-26T00:47:01.081782Z","end":"2026-04-26T00:47:01.277259Z","steps":["trace[1011579483] 'agreement among raft nodes before linearized reading' (duration: 195.286575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:47:01.277343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.429446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nlw5l\" ","response":"range_response_count:1 size:6441"} {"level":"info","ts":"2026-04-26T00:47:01.277436Z","caller":"traceutil/trace.go:171","msg":"trace[1087030557] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nlw5l; range_end:; response_count:1; response_revision:4194; }","duration":"190.554159ms","start":"2026-04-26T00:47:01.08686Z","end":"2026-04-26T00:47:01.277414Z","steps":["trace[1087030557] 'agreement among raft nodes before linearized reading' (duration: 190.269263ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:51:05.029106Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3729} {"level":"info","ts":"2026-04-26T00:51:05.122501Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3729,"took":"91.817619ms","hash":438927198,"current-db-size-bytes":46297088,"current-db-size":"46 MB","current-db-size-in-use-bytes":19742720,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-26T00:51:05.122585Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":438927198,"revision":3729,"compact-revision":-1} {"level":"info","ts":"2026-04-26T00:51:53.950564Z","caller":"traceutil/trace.go:171","msg":"trace[885428661] transaction","detail":"{read_only:false; response_revision:6377; number_of_response:1; }","duration":"119.632702ms","start":"2026-04-26T00:51:53.830904Z","end":"2026-04-26T00:51:53.950537Z","steps":["trace[885428661] 'process raft request' (duration: 101.884809ms)","trace[885428661] 'compare' (duration: 17.477007ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T00:51:53.950639Z","caller":"traceutil/trace.go:171","msg":"trace[996061472] transaction","detail":"{read_only:false; response_revision:6378; number_of_response:1; }","duration":"118.069385ms","start":"2026-04-26T00:51:53.832528Z","end":"2026-04-26T00:51:53.950597Z","steps":["trace[996061472] 'process raft request' (duration: 117.923321ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:51:53.950599Z","caller":"traceutil/trace.go:171","msg":"trace[1030657941] linearizableReadLoop","detail":"{readStateIndex:6599; appliedIndex:6596; }","duration":"115.706349ms","start":"2026-04-26T00:51:53.834866Z","end":"2026-04-26T00:51:53.950572Z","steps":["trace[1030657941] 'read index received' (duration: 54.348676ms)","trace[1030657941] 'applied index is now lower than readState.Index' (duration: 61.356643ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T00:51:53.950814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.922194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-glance\" ","response":"range_response_count:1 size:3306"} {"level":"info","ts":"2026-04-26T00:51:53.950864Z","caller":"traceutil/trace.go:171","msg":"trace[1465119294] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-glance; range_end:; response_count:1; response_revision:6379; }","duration":"115.997956ms","start":"2026-04-26T00:51:53.83485Z","end":"2026-04-26T00:51:53.950847Z","steps":["trace[1465119294] 'agreement among raft nodes before linearized reading' (duration: 115.803751ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:52:12.176001Z","caller":"traceutil/trace.go:171","msg":"trace[510040141] transaction","detail":"{read_only:false; response_revision:6832; number_of_response:1; }","duration":"102.676158ms","start":"2026-04-26T00:52:12.073293Z","end":"2026-04-26T00:52:12.175969Z","steps":["trace[510040141] 'process raft request' (duration: 102.468573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:35.418768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.974723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-26T00:52:35.418783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.020544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-bootstrap\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:52:35.418862Z","caller":"traceutil/trace.go:171","msg":"trace[1583609240] range","detail":"{range_begin:/registry/jobs/openstack/heat-db-sync; range_end:; response_count:0; response_revision:7564; }","duration":"105.089176ms","start":"2026-04-26T00:52:35.313758Z","end":"2026-04-26T00:52:35.418847Z","steps":["trace[1583609240] 'agreement among raft nodes before linearized reading' (duration: 104.965953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:35.418834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.044165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-26T00:52:35.418871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.119827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:52:35.418946Z","caller":"traceutil/trace.go:171","msg":"trace[1222399471] range","detail":"{range_begin:/registry/jobs/openstack/heat-rabbit-init; range_end:; response_count:0; response_revision:7564; }","duration":"105.233149ms","start":"2026-04-26T00:52:35.313698Z","end":"2026-04-26T00:52:35.418931Z","steps":["trace[1222399471] 'agreement among raft nodes before linearized reading' (duration: 105.076325ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:52:35.418939Z","caller":"traceutil/trace.go:171","msg":"trace[1337700553] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-endpoints; range_end:; response_count:0; response_revision:7564; }","duration":"105.191378ms","start":"2026-04-26T00:52:35.31373Z","end":"2026-04-26T00:52:35.418921Z","steps":["trace[1337700553] 'agreement among raft nodes before linearized reading' (duration: 105.011694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:35.418932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.119296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-domain-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:52:35.418894Z","caller":"traceutil/trace.go:171","msg":"trace[1577273554] range","detail":"{range_begin:/registry/jobs/openstack/heat-bootstrap; range_end:; response_count:0; response_revision:7564; }","duration":"105.182698ms","start":"2026-04-26T00:52:35.313688Z","end":"2026-04-26T00:52:35.418871Z","steps":["trace[1577273554] 'agreement among raft nodes before linearized reading' (duration: 105.040074ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:52:35.419023Z","caller":"traceutil/trace.go:171","msg":"trace[508673410] range","detail":"{range_begin:/registry/jobs/openstack/heat-domain-ks-user; range_end:; response_count:0; response_revision:7564; }","duration":"105.23932ms","start":"2026-04-26T00:52:35.313765Z","end":"2026-04-26T00:52:35.419005Z","steps":["trace[508673410] 'agreement among raft nodes before linearized reading' (duration: 105.067936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:36.623968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.082137ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-26T00:52:36.624065Z","caller":"traceutil/trace.go:171","msg":"trace[1690543485] linearizableReadLoop","detail":"{readStateIndex:7834; appliedIndex:7833; }","duration":"118.911706ms","start":"2026-04-26T00:52:36.505138Z","end":"2026-04-26T00:52:36.624049Z","steps":["trace[1690543485] 'read index received' (duration: 5.586473ms)","trace[1690543485] 'applied index is now lower than readState.Index' (duration: 113.324073ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T00:52:36.624204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.059269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:52:36.624164Z","caller":"traceutil/trace.go:171","msg":"trace[381863292] transaction","detail":"{read_only:false; response_revision:7596; number_of_response:1; }","duration":"127.116581ms","start":"2026-04-26T00:52:36.497006Z","end":"2026-04-26T00:52:36.624122Z","steps":["trace[381863292] 'process raft request' (duration: 13.765089ms)","trace[381863292] 'compare' (duration: 112.939633ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T00:52:36.624237Z","caller":"traceutil/trace.go:171","msg":"trace[1423535672] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:0; response_revision:7596; }","duration":"119.12044ms","start":"2026-04-26T00:52:36.505108Z","end":"2026-04-26T00:52:36.624228Z","steps":["trace[1423535672] 'agreement among raft nodes before linearized reading' (duration: 119.029448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:36.624575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.084084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" ","response":"range_response_count:1 size:1148"} {"level":"info","ts":"2026-04-26T00:52:36.624614Z","caller":"traceutil/trace.go:171","msg":"trace[2045015014] range","detail":"{range_begin:/registry/services/endpoints/openstack/percona-xtradb-haproxy; range_end:; response_count:1; response_revision:7596; }","duration":"115.147465ms","start":"2026-04-26T00:52:36.509455Z","end":"2026-04-26T00:52:36.624602Z","steps":["trace[2045015014] 'agreement among raft nodes before linearized reading' (duration: 115.015662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:36.624935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.200366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-db-init\" ","response":"range_response_count:1 size:5476"} {"level":"info","ts":"2026-04-26T00:52:36.624992Z","caller":"traceutil/trace.go:171","msg":"trace[1115278004] range","detail":"{range_begin:/registry/jobs/openstack/heat-db-init; range_end:; response_count:1; response_revision:7596; }","duration":"115.295359ms","start":"2026-04-26T00:52:36.509683Z","end":"2026-04-26T00:52:36.624979Z","steps":["trace[1115278004] 'agreement among raft nodes before linearized reading' (duration: 115.092554ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:52:38.07057Z","caller":"traceutil/trace.go:171","msg":"trace[1606284999] transaction","detail":"{read_only:false; response_revision:7618; number_of_response:1; }","duration":"111.331645ms","start":"2026-04-26T00:52:37.959217Z","end":"2026-04-26T00:52:38.070548Z","steps":["trace[1606284999] 'process raft request' (duration: 76.065064ms)","trace[1606284999] 'compare' (duration: 34.773739ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T00:52:44.851628Z","caller":"traceutil/trace.go:171","msg":"trace[2139848206] transaction","detail":"{read_only:false; response_revision:7800; number_of_response:1; }","duration":"130.618705ms","start":"2026-04-26T00:52:44.720979Z","end":"2026-04-26T00:52:44.851598Z","steps":["trace[2139848206] 'process raft request' (duration: 130.402879ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:52:44.859817Z","caller":"traceutil/trace.go:171","msg":"trace[1586373706] linearizableReadLoop","detail":"{readStateIndex:8042; appliedIndex:8040; }","duration":"129.605081ms","start":"2026-04-26T00:52:44.730191Z","end":"2026-04-26T00:52:44.859796Z","steps":["trace[1586373706] 'read index received' (duration: 121.208331ms)","trace[1586373706] 'applied index is now lower than readState.Index' (duration: 8.3959ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T00:52:44.860184Z","caller":"traceutil/trace.go:171","msg":"trace[287954773] transaction","detail":"{read_only:false; response_revision:7801; number_of_response:1; }","duration":"136.135546ms","start":"2026-04-26T00:52:44.724035Z","end":"2026-04-26T00:52:44.86017Z","steps":["trace[287954773] 'process raft request' (duration: 135.617784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:44.860413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.197925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-04-26T00:52:44.860526Z","caller":"traceutil/trace.go:171","msg":"trace[165109703] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:7802; }","duration":"130.352699ms","start":"2026-04-26T00:52:44.730146Z","end":"2026-04-26T00:52:44.860499Z","steps":["trace[165109703] 'agreement among raft nodes before linearized reading' (duration: 130.046831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:44.886198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.312377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-26T00:52:44.886652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.11558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0\" ","response":"range_response_count:1 size:1565"} {"level":"info","ts":"2026-04-26T00:52:44.886744Z","caller":"traceutil/trace.go:171","msg":"trace[693810928] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0; range_end:; response_count:1; response_revision:7803; }","duration":"114.249684ms","start":"2026-04-26T00:52:44.772474Z","end":"2026-04-26T00:52:44.886723Z","steps":["trace[693810928] 'agreement among raft nodes before linearized reading' (duration: 114.05336ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:52:44.886755Z","caller":"traceutil/trace.go:171","msg":"trace[1957635187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7803; }","duration":"138.899721ms","start":"2026-04-26T00:52:44.747839Z","end":"2026-04-26T00:52:44.886739Z","steps":["trace[1957635187] 'agreement among raft nodes before linearized reading' (duration: 138.296947ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:52:45.772577Z","caller":"traceutil/trace.go:171","msg":"trace[1496298868] linearizableReadLoop","detail":"{readStateIndex:8046; appliedIndex:8045; }","duration":"156.552942ms","start":"2026-04-26T00:52:45.616005Z","end":"2026-04-26T00:52:45.772558Z","steps":["trace[1496298868] 'read index received' (duration: 156.365987ms)","trace[1496298868] 'applied index is now lower than readState.Index' (duration: 185.975µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T00:52:45.772913Z","caller":"traceutil/trace.go:171","msg":"trace[1447950922] transaction","detail":"{read_only:false; response_revision:7805; number_of_response:1; }","duration":"185.082273ms","start":"2026-04-26T00:52:45.587817Z","end":"2026-04-26T00:52:45.7729Z","steps":["trace[1447950922] 'process raft request' (duration: 184.616021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:45.773167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.147296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/placement-ks-user\" ","response":"range_response_count:1 size:7366"} {"level":"info","ts":"2026-04-26T00:52:45.773202Z","caller":"traceutil/trace.go:171","msg":"trace[801540164] range","detail":"{range_begin:/registry/jobs/openstack/placement-ks-user; range_end:; response_count:1; response_revision:7805; }","duration":"157.191257ms","start":"2026-04-26T00:52:45.616Z","end":"2026-04-26T00:52:45.773191Z","steps":["trace[801540164] 'agreement among raft nodes before linearized reading' (duration: 157.060094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:45.773482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.324545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/placement-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:52:45.773515Z","caller":"traceutil/trace.go:171","msg":"trace[2126370545] range","detail":"{range_begin:/registry/jobs/openstack/placement-ks-endpoints; range_end:; response_count:0; response_revision:7805; }","duration":"145.384206ms","start":"2026-04-26T00:52:45.628121Z","end":"2026-04-26T00:52:45.773505Z","steps":["trace[2126370545] 'agreement among raft nodes before linearized reading' (duration: 145.335345ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:52:51.280528Z","caller":"traceutil/trace.go:171","msg":"trace[1178032521] linearizableReadLoop","detail":"{readStateIndex:8197; appliedIndex:8196; }","duration":"147.379463ms","start":"2026-04-26T00:52:51.133128Z","end":"2026-04-26T00:52:51.280507Z","steps":["trace[1178032521] 'read index received' (duration: 147.162538ms)","trace[1178032521] 'applied index is now lower than readState.Index' (duration: 216.095µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T00:52:51.280592Z","caller":"traceutil/trace.go:171","msg":"trace[1803661835] transaction","detail":"{read_only:false; response_revision:7949; number_of_response:1; }","duration":"229.728797ms","start":"2026-04-26T00:52:51.050824Z","end":"2026-04-26T00:52:51.280553Z","steps":["trace[1803661835] 'process raft request' (duration: 229.544372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:51.280806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.66606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-domain-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:52:51.281534Z","caller":"traceutil/trace.go:171","msg":"trace[1767140882] range","detail":"{range_begin:/registry/jobs/openstack/heat-domain-ks-user; range_end:; response_count:0; response_revision:7949; }","duration":"148.432948ms","start":"2026-04-26T00:52:51.133081Z","end":"2026-04-26T00:52:51.281514Z","steps":["trace[1767140882] 'agreement among raft nodes before linearized reading' (duration: 147.631619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:51.28101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.65836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:52:51.281675Z","caller":"traceutil/trace.go:171","msg":"trace[1625281250] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-endpoints; range_end:; response_count:0; response_revision:7949; }","duration":"148.338496ms","start":"2026-04-26T00:52:51.133328Z","end":"2026-04-26T00:52:51.281666Z","steps":["trace[1625281250] 'agreement among raft nodes before linearized reading' (duration: 147.66754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:51.281143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.754982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-bootstrap\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:52:51.281752Z","caller":"traceutil/trace.go:171","msg":"trace[618198919] range","detail":"{range_begin:/registry/jobs/openstack/heat-bootstrap; range_end:; response_count:0; response_revision:7949; }","duration":"148.365406ms","start":"2026-04-26T00:52:51.133371Z","end":"2026-04-26T00:52:51.281737Z","steps":["trace[618198919] 'agreement among raft nodes before linearized reading' (duration: 147.759582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:51.28118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.052836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T00:52:51.281884Z","caller":"traceutil/trace.go:171","msg":"trace[1617765380] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-user; range_end:; response_count:0; response_revision:7949; }","duration":"147.797923ms","start":"2026-04-26T00:52:51.134069Z","end":"2026-04-26T00:52:51.281867Z","steps":["trace[1617765380] 'agreement among raft nodes before linearized reading' (duration: 147.025255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:52:51.281291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.395834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-rabbit-init\" ","response":"range_response_count:1 size:4839"} {"level":"info","ts":"2026-04-26T00:52:51.282002Z","caller":"traceutil/trace.go:171","msg":"trace[477333381] range","detail":"{range_begin:/registry/jobs/openstack/heat-rabbit-init; range_end:; response_count:1; response_revision:7949; }","duration":"148.147301ms","start":"2026-04-26T00:52:51.133848Z","end":"2026-04-26T00:52:51.281995Z","steps":["trace[477333381] 'agreement among raft nodes before linearized reading' (duration: 147.24305ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:52:51.451932Z","caller":"traceutil/trace.go:171","msg":"trace[145114135] transaction","detail":"{read_only:false; response_revision:7951; number_of_response:1; }","duration":"133.991314ms","start":"2026-04-26T00:52:51.317888Z","end":"2026-04-26T00:52:51.451879Z","steps":["trace[145114135] 'process raft request' (duration: 93.11457ms)","trace[145114135] 'compare' (duration: 39.89588ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T00:52:51.452392Z","caller":"traceutil/trace.go:171","msg":"trace[1987579313] transaction","detail":"{read_only:false; response_revision:7952; number_of_response:1; }","duration":"131.147666ms","start":"2026-04-26T00:52:51.321226Z","end":"2026-04-26T00:52:51.452373Z","steps":["trace[1987579313] 'process raft request' (duration: 129.926727ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:53:02.378067Z","caller":"traceutil/trace.go:171","msg":"trace[908459688] transaction","detail":"{read_only:false; response_revision:8133; number_of_response:1; }","duration":"110.441213ms","start":"2026-04-26T00:53:02.267602Z","end":"2026-04-26T00:53:02.378043Z","steps":["trace[908459688] 'process raft request' (duration: 109.812908ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:53:30.754036Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002284.wal"} {"level":"info","ts":"2026-04-26T00:53:44.963907Z","caller":"traceutil/trace.go:171","msg":"trace[320774200] linearizableReadLoop","detail":"{readStateIndex:9490; appliedIndex:9489; }","duration":"125.297896ms","start":"2026-04-26T00:53:44.838589Z","end":"2026-04-26T00:53:44.963887Z","steps":["trace[320774200] 'read index received' (duration: 40.484538ms)","trace[320774200] 'applied index is now lower than readState.Index' (duration: 84.812468ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T00:53:44.964019Z","caller":"traceutil/trace.go:171","msg":"trace[1100489960] transaction","detail":"{read_only:false; response_revision:9208; number_of_response:1; }","duration":"125.956373ms","start":"2026-04-26T00:53:44.838028Z","end":"2026-04-26T00:53:44.963984Z","steps":["trace[1100489960] 'process raft request' (duration: 41.093703ms)","trace[1100489960] 'compare' (duration: 84.657815ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T00:53:44.964347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.234799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4736"} {"level":"info","ts":"2026-04-26T00:53:44.964453Z","caller":"traceutil/trace.go:171","msg":"trace[255752712] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:9208; }","duration":"121.364202ms","start":"2026-04-26T00:53:44.843073Z","end":"2026-04-26T00:53:44.964437Z","steps":["trace[255752712] 'agreement among raft nodes before linearized reading' (duration: 121.164258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:53:44.964647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.462351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-26T00:53:44.964711Z","caller":"traceutil/trace.go:171","msg":"trace[1619171876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9208; }","duration":"115.540303ms","start":"2026-04-26T00:53:44.849148Z","end":"2026-04-26T00:53:44.964688Z","steps":["trace[1619171876] 'agreement among raft nodes before linearized reading' (duration: 115.41304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:53:44.964976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.84044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-26T00:53:44.96508Z","caller":"traceutil/trace.go:171","msg":"trace[682972139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9208; }","duration":"115.985113ms","start":"2026-04-26T00:53:44.849082Z","end":"2026-04-26T00:53:44.965067Z","steps":["trace[682972139] 'agreement among raft nodes before linearized reading' (duration: 115.815639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:53:44.964446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.803958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"} {"level":"info","ts":"2026-04-26T00:53:44.965286Z","caller":"traceutil/trace.go:171","msg":"trace[420642469] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:9208; }","duration":"126.7293ms","start":"2026-04-26T00:53:44.838543Z","end":"2026-04-26T00:53:44.965272Z","steps":["trace[420642469] 'agreement among raft nodes before linearized reading' (duration: 125.680365ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:54:05.191424Z","caller":"traceutil/trace.go:171","msg":"trace[1127982527] linearizableReadLoop","detail":"{readStateIndex:9958; appliedIndex:9956; }","duration":"103.422332ms","start":"2026-04-26T00:54:05.087982Z","end":"2026-04-26T00:54:05.191405Z","steps":["trace[1127982527] 'read index received' (duration: 8.946734ms)","trace[1127982527] 'applied index is now lower than readState.Index' (duration: 94.474828ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T00:54:05.191661Z","caller":"traceutil/trace.go:171","msg":"trace[349991431] transaction","detail":"{read_only:false; response_revision:9668; number_of_response:1; }","duration":"147.105928ms","start":"2026-04-26T00:54:05.044542Z","end":"2026-04-26T00:54:05.191647Z","steps":["trace[349991431] 'process raft request' (duration: 112.211163ms)","trace[349991431] 'compare' (duration: 34.350391ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T00:54:05.19197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.017756ms","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-04-26T00:54:05.192487Z","caller":"traceutil/trace.go:171","msg":"trace[1273670061] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9668; }","duration":"101.435955ms","start":"2026-04-26T00:54:05.09091Z","end":"2026-04-26T00:54:05.192345Z","steps":["trace[1273670061] 'agreement among raft nodes before linearized reading' (duration: 100.924373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T00:54:05.193121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.134113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17121"} {"level":"info","ts":"2026-04-26T00:54:05.193141Z","caller":"traceutil/trace.go:171","msg":"trace[24905145] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:9668; }","duration":"105.189555ms","start":"2026-04-26T00:54:05.087944Z","end":"2026-04-26T00:54:05.193133Z","steps":["trace[24905145] 'agreement among raft nodes before linearized reading' (duration: 105.076162ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:54:05.392024Z","caller":"traceutil/trace.go:171","msg":"trace[6784375] transaction","detail":"{read_only:false; response_revision:9676; number_of_response:1; }","duration":"103.083866ms","start":"2026-04-26T00:54:05.288905Z","end":"2026-04-26T00:54:05.391989Z","steps":["trace[6784375] 'process raft request' (duration: 102.963083ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:54:05.392054Z","caller":"traceutil/trace.go:171","msg":"trace[184890484] transaction","detail":"{read_only:false; response_revision:9675; number_of_response:1; }","duration":"103.368762ms","start":"2026-04-26T00:54:05.288657Z","end":"2026-04-26T00:54:05.392025Z","steps":["trace[184890484] 'process raft request' (duration: 103.019514ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:54:05.392435Z","caller":"traceutil/trace.go:171","msg":"trace[2048008093] transaction","detail":"{read_only:false; response_revision:9677; number_of_response:1; }","duration":"102.662525ms","start":"2026-04-26T00:54:05.289763Z","end":"2026-04-26T00:54:05.392426Z","steps":["trace[2048008093] 'process raft request' (duration: 102.172943ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T00:54:09.202415Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"fb85913747d92cac","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-26T00:54:09.212628Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-26T00:54:09.212752Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-26T00:56:05.03598Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5824} {"level":"info","ts":"2026-04-26T00:56:05.108109Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5824,"took":"69.528648ms","hash":4121761861,"current-db-size-bytes":55980032,"current-db-size":"56 MB","current-db-size-in-use-bytes":49999872,"current-db-size-in-use":"50 MB"} {"level":"info","ts":"2026-04-26T00:56:05.108198Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4121761861,"revision":5824,"compact-revision":3729}