2026/02/17 02:48:24 Running command:
Command env: (log-file=, also-stdout=false, redirect-stderr=true)
Run from directory: 
Executable path: /bin/openstack-cloud-controller-manager
Args (comma-delimited): /bin/openstack-cloud-controller-manager,--v=2,--cloud-config=/etc/config/cloud.conf,--cluster-name=8758f80b-a4c9-460d-9953-d892f2dc02bf,--cloud-provider=openstack,--use-service-account-credentials=false,--controllers=cloud-node,cloud-node-lifecycle,route,service,--bind-address=127.0.0.1
2026/02/17 02:48:24 Now listening for interrupts
I0217 02:48:26.289622      12 serving.go:386] Generated self-signed cert in-memory
I0217 02:48:27.314906      12 serving.go:386] Generated self-signed cert in-memory
W0217 02:48:27.315061      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:48:27.988488      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:48:28.061901      12 controllermanager.go:160] Version: v1.33.1
I0217 02:48:28.475319      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296506\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296504\" (2026-02-17 01:48:24 +0000 UTC to 2027-02-17 01:48:24 +0000 UTC (now=2026-02-17 02:48:28.475235206 +0000 UTC))"
I0217 02:48:28.475753      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296507\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296507\" (2026-02-17 01:48:27 +0000 UTC to 2029-02-17 01:48:27 +0000 UTC (now=2026-02-17 02:48:28.475739157 +0000 UTC))"
I0217 02:48:28.475833      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:48:28.477241      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:48:28.477493      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:48:28.477569      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:48:28.477608      12 shared_informer.go:350] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 02:48:28.477820      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:48:28.477849      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:48:28.479057      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:48:28.479501      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:48:28.488687      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:48:28.492213      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:48:28.492890      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:48:28.578708      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:48:28.581113      12 tlsconfig.go:181] "Loaded client CA" index=0 certName="client-ca::kube-system::extension-apiserver-authentication::client-ca-file,client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file" certDetail="\"k8s-cluster\" [] issuer=\"<self>\" (2026-02-16 02:40:59 +0000 UTC to 2031-02-16 02:40:59 +0000 UTC (now=2026-02-17 02:48:28.581069947 +0000 UTC))"
I0217 02:48:28.581643      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296506\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296504\" (2026-02-17 01:48:24 +0000 UTC to 2027-02-17 01:48:24 +0000 UTC (now=2026-02-17 02:48:28.581627641 +0000 UTC))"
I0217 02:48:28.581168      12 shared_informer.go:357] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 02:48:28.582147      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296507\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296507\" (2026-02-17 01:48:27 +0000 UTC to 2029-02-17 01:48:27 +0000 UTC (now=2026-02-17 02:48:28.582125812 +0000 UTC))"
I0217 02:48:28.598041      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:48:28.598665      12 tlsconfig.go:181] "Loaded client CA" index=0 certName="client-ca::kube-system::extension-apiserver-authentication::client-ca-file,client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file" certDetail="\"k8s-cluster\" [] issuer=\"<self>\" (2026-02-16 02:40:56 +0000 UTC to 2031-02-16 02:40:56 +0000 UTC (now=2026-02-17 02:48:28.5986261 +0000 UTC))"
I0217 02:48:28.598778      12 tlsconfig.go:181] "Loaded client CA" index=1 certName="client-ca::kube-system::extension-apiserver-authentication::client-ca-file,client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file" certDetail="\"k8s-cluster\" [] issuer=\"<self>\" (2026-02-16 02:40:59 +0000 UTC to 2031-02-16 02:40:59 +0000 UTC (now=2026-02-17 02:48:28.598769369 +0000 UTC))"
I0217 02:48:28.599111      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296506\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296504\" (2026-02-17 01:48:24 +0000 UTC to 2027-02-17 01:48:24 +0000 UTC (now=2026-02-17 02:48:28.599101449 +0000 UTC))"
I0217 02:48:28.599556      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296507\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296507\" (2026-02-17 01:48:27 +0000 UTC to 2029-02-17 01:48:27 +0000 UTC (now=2026-02-17 02:48:28.599542316 +0000 UTC))"
I0217 02:48:30.009148      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:48:30.010465      12 event.go:389] "Event occurred" object="kube-system/cloud-controller-manager" fieldPath="" kind="Lease" apiVersion="coordination.k8s.io/v1" type="Normal" reason="LeaderElection" message="kube-hccv2-gp5r7-z2sdk_a3d1ceb5-6303-4c21-a81f-36a6b8957b84 became leader"
I0217 02:48:30.017099      12 openstack.go:424] Setting up informers for Cloud
I0217 02:48:30.017274      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:48:30.017847      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:48:30.017978      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:48:30.018475      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:48:30.018731      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:48:30.018048      12 node_controller.go:176] Sending events to api server.
I0217 02:48:30.019237      12 node_controller.go:185] Waiting for informer caches to sync
I0217 02:48:30.020429      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:48:30.041085      12 openstack.go:373] Claiming to support LoadBalancer
I0217 02:48:30.043803      12 controllermanager.go:329] Started "service-lb-controller"
I0217 02:48:30.043845      12 controllermanager.go:310] Starting "node-route-controller"
I0217 02:48:30.044293      12 controller.go:234] Starting service controller
I0217 02:48:30.044503      12 shared_informer.go:350] "Waiting for caches to sync" controller="service"
W0217 02:48:30.104087      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:48:30.104145      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:48:30.104156      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:48:30.118516      12 reflector.go:430] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:48:30.118612      12 reflector.go:430] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:48:30.121723      12 node_controller.go:429] Initializing node kube-hccv2-default-worker-bmqqz-grr6p-tcg6z with cloud provider
I0217 02:48:30.121924      12 node_controller.go:271] Update 2 nodes status took 141.779µs.
I0217 02:48:30.158619      12 shared_informer.go:357] "Caches are synced" controller="service"
I0217 02:48:30.161338      12 controller.go:722] Syncing backends for all LB services.
I0217 02:48:30.161382      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:48:30.161406      12 controller.go:722] Syncing backends for all LB services.
I0217 02:48:30.161410      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:48:31.302824      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:48:31.302920      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:48:31.302935      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:48:31.302945      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:48:31.302955      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:48:31.302970      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:48:31.344534      12 controller.go:722] Syncing backends for all LB services.
I0217 02:48:31.344657      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:48:31.858700      12 node_controller.go:474] Successfully initialized node kube-hccv2-default-worker-bmqqz-grr6p-tcg6z with cloud provider
I0217 02:48:31.858808      12 node_controller.go:429] Initializing node kube-hccv2-gp5r7-z2sdk with cloud provider
I0217 02:48:31.860792      12 event.go:389] "Event occurred" object="kube-hccv2-default-worker-bmqqz-grr6p-tcg6z" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:48:32.345811      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:48:32.345896      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:48:32.345908      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:48:32.345917      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:48:32.345927      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:48:32.345936      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:48:33.515070      12 controller.go:722] Syncing backends for all LB services.
I0217 02:48:33.515119      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:48:33.613027      12 node_controller.go:474] Successfully initialized node kube-hccv2-gp5r7-z2sdk with cloud provider
I0217 02:48:33.613702      12 event.go:389] "Event occurred" object="kube-hccv2-gp5r7-z2sdk" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:48:35.348372      12 controller.go:722] Syncing backends for all LB services.
I0217 02:48:35.348564      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:48:35.348742      12 node_controller.go:429] Initializing node kube-hccv2-default-worker-bmqqz-grr6p-zsbt6 with cloud provider
I0217 02:48:36.123969      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:48:36.124032      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:48:36.124038      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:48:36.124083      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:48:36.124089      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:48:36.124094      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:48:36.148907      12 controller.go:722] Syncing backends for all LB services.
I0217 02:48:36.148946      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:48:36.188955      12 node_controller.go:474] Successfully initialized node kube-hccv2-default-worker-bmqqz-grr6p-zsbt6 with cloud provider
I0217 02:48:36.192792      12 event.go:389] "Event occurred" object="kube-hccv2-default-worker-bmqqz-grr6p-zsbt6" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
E0217 02:49:49.147556      12 leaderelection.go:429] Failed to update lock optimistically: Put "https://10.254.0.1:443/apis/coordination.k8s.io/v1/namespaces/kube-system/leases/cloud-controller-manager?timeout=5s": context deadline exceeded, falling back to slow path
I0217 02:53:31.423555      12 node_controller.go:271] Update 3 nodes status took 1.300347493s.
I0217 02:58:32.742164      12 node_controller.go:271] Update 3 nodes status took 1.317268852s.
I0217 03:03:34.167165      12 node_controller.go:271] Update 3 nodes status took 1.418733323s.
I0217 03:04:26.868393      12 controller.go:722] Syncing backends for all LB services.
I0217 03:04:26.868620      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 03:04:27.017541      12 controller.go:722] Syncing backends for all LB services.
I0217 03:04:27.021524      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 03:08:35.498255      12 node_controller.go:271] Update 3 nodes status took 1.329451781s.
I0217 03:13:36.746227      12 node_controller.go:271] Update 3 nodes status took 1.246772147s.
