2026/02/17 02:38:28 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=c5731a97-0dfe-41a2-b05f-96b8092158e4,--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:38:28 Now listening for interrupts
I0217 02:38:28.842884      12 serving.go:386] Generated self-signed cert in-memory
I0217 02:38:29.652780      12 serving.go:386] Generated self-signed cert in-memory
W0217 02:38:29.652913      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:38:30.331050      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:38:30.386087      12 controllermanager.go:160] Version: v1.33.1
I0217 02:38:30.395251      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295908\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295908\" (2026-02-17 01:38:28 +0000 UTC to 2027-02-17 01:38:28 +0000 UTC (now=2026-02-17 02:38:30.395216302 +0000 UTC))"
I0217 02:38:30.395421      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295910\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295910\" (2026-02-17 01:38:29 +0000 UTC to 2029-02-17 01:38:29 +0000 UTC (now=2026-02-17 02:38:30.395409725 +0000 UTC))"
I0217 02:38:30.395448      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:38:30.395502      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:38:30.395497      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:38:30.395581      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:38:30.395602      12 shared_informer.go:350] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 02:38:30.395809      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:38:30.396235      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:38:30.397789      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:38:30.397836      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:38:30.402423      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:38:30.403607      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:38:30.404470      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:38:30.413412      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:38:30.413921      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-pbufp-hvtv8-zr8wz_0bd682d8-aee7-4738-9bd8-58892a831db5 became leader"
I0217 02:38:30.421466      12 openstack.go:424] Setting up informers for Cloud
I0217 02:38:30.421527      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:38:30.422281      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:38:30.422292      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:38:30.422801      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:38:30.422950      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:38:30.423363      12 node_controller.go:176] Sending events to api server.
I0217 02:38:30.423603      12 node_controller.go:185] Waiting for informer caches to sync
I0217 02:38:30.423819      12 openstack.go:373] Claiming to support LoadBalancer
I0217 02:38:30.423949      12 controllermanager.go:329] Started "service-lb-controller"
I0217 02:38:30.423985      12 controllermanager.go:310] Starting "node-route-controller"
I0217 02:38:30.424244      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:38:30.424382      12 controller.go:234] Starting service controller
I0217 02:38:30.424885      12 shared_informer.go:350] "Waiting for caches to sync" controller="service"
W0217 02:38:30.485828      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:38:30.486185      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:38:30.486365      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:38:30.495303      12 reflector.go:430] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:38:30.495704      12 shared_informer.go:357] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 02:38:30.495725      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:38:30.496468      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:29:33 +0000 UTC to 2031-02-16 02:29:33 +0000 UTC (now=2026-02-17 02:38:30.496444207 +0000 UTC))"
I0217 02:38:30.496590      12 reflector.go:430] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:38:30.498038      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295908\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295908\" (2026-02-17 01:38:28 +0000 UTC to 2027-02-17 01:38:28 +0000 UTC (now=2026-02-17 02:38:30.498014996 +0000 UTC))"
I0217 02:38:30.498531      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:38:30.498757      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295910\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295910\" (2026-02-17 01:38:29 +0000 UTC to 2029-02-17 01:38:29 +0000 UTC (now=2026-02-17 02:38:30.498735967 +0000 UTC))"
I0217 02:38:30.499374      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:29:31 +0000 UTC to 2031-02-16 02:29:31 +0000 UTC (now=2026-02-17 02:38:30.49936365 +0000 UTC))"
I0217 02:38:30.499412      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:29:33 +0000 UTC to 2031-02-16 02:29:33 +0000 UTC (now=2026-02-17 02:38:30.499405263 +0000 UTC))"
I0217 02:38:30.499780      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295908\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295908\" (2026-02-17 01:38:28 +0000 UTC to 2027-02-17 01:38:28 +0000 UTC (now=2026-02-17 02:38:30.499770539 +0000 UTC))"
I0217 02:38:30.500168      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295910\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295910\" (2026-02-17 01:38:29 +0000 UTC to 2029-02-17 01:38:29 +0000 UTC (now=2026-02-17 02:38:30.500151726 +0000 UTC))"
I0217 02:38:30.525185      12 node_controller.go:429] Initializing node kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf with cloud provider
I0217 02:38:30.525276      12 shared_informer.go:357] "Caches are synced" controller="service"
I0217 02:38:30.526132      12 node_controller.go:271] Update 3 nodes status took 1.086836ms.
I0217 02:38:30.526236      12 controller.go:722] Syncing backends for all LB services.
I0217 02:38:30.526367      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:38:30.527218      12 controller.go:722] Syncing backends for all LB services.
I0217 02:38:30.527499      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:38:30.527692      12 controller.go:722] Syncing backends for all LB services.
I0217 02:38:30.528160      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:38:31.056493      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:38:31.056652      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:38:31.056683      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:38:31.056801      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:38:31.056831      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:38:31.056934      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:38:31.100242      12 controller.go:722] Syncing backends for all LB services.
I0217 02:38:31.100620      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:38:31.156260      12 node_controller.go:474] Successfully initialized node kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf with cloud provider
I0217 02:38:31.156375      12 node_controller.go:429] Initializing node kube-pbufp-default-worker-7hjxz-m6tmm-kb8cf with cloud provider
I0217 02:38:31.157218      12 event.go:389] "Event occurred" object="kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:38:31.741153      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:38:31.742893      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:38:31.742927      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:38:31.742935      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:38:31.742943      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:38:31.742950      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:38:31.772805      12 controller.go:722] Syncing backends for all LB services.
I0217 02:38:31.772851      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:38:31.871851      12 node_controller.go:474] Successfully initialized node kube-pbufp-default-worker-7hjxz-m6tmm-kb8cf with cloud provider
I0217 02:38:31.871941      12 node_controller.go:429] Initializing node kube-pbufp-hvtv8-zr8wz with cloud provider
I0217 02:38:31.873763      12 event.go:389] "Event occurred" object="kube-pbufp-default-worker-7hjxz-m6tmm-kb8cf" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:38:32.337284      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:38:32.337336      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:38:32.337343      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:38:32.337349      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:38:32.337356      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:38:32.337363      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:38:32.349183      12 controller.go:722] Syncing backends for all LB services.
I0217 02:38:32.349225      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:38:32.379353      12 node_controller.go:474] Successfully initialized node kube-pbufp-hvtv8-zr8wz with cloud provider
I0217 02:38:32.380326      12 event.go:389] "Event occurred" object="kube-pbufp-hvtv8-zr8wz" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:43:31.958164      12 node_controller.go:271] Update 3 nodes status took 1.430453964s.
I0217 02:48:33.256948      12 node_controller.go:271] Update 3 nodes status took 1.296748633s.
I0217 02:53:34.565775      12 node_controller.go:271] Update 3 nodes status took 1.307761156s.
I0217 02:58:24.343017      12 controller.go:722] Syncing backends for all LB services.
I0217 02:58:24.343073      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:58:24.446582      12 controller.go:722] Syncing backends for all LB services.
I0217 02:58:24.446758      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:58:36.351593      12 node_controller.go:271] Update 3 nodes status took 1.785184442s.
