2026/02/17 02:24:02 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=261ca2c7-fde8-4e36-8091-e88e15323014,--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:24:02 Now listening for interrupts
I0217 02:24:03.829689      12 serving.go:386] Generated self-signed cert in-memory
I0217 02:24:04.310159      12 serving.go:386] Generated self-signed cert in-memory
W0217 02:24:04.310222      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:24:04.971657      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:24:05.026823      12 controllermanager.go:160] Version: v1.33.1
I0217 02:24:05.033793      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295043\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295043\" (2026-02-17 01:24:02 +0000 UTC to 2027-02-17 01:24:02 +0000 UTC (now=2026-02-17 02:24:05.033626366 +0000 UTC))"
I0217 02:24:05.035009      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295044\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295044\" (2026-02-17 01:24:04 +0000 UTC to 2029-02-17 01:24:04 +0000 UTC (now=2026-02-17 02:24:05.034869243 +0000 UTC))"
I0217 02:24:05.035223      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:24:05.035909      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:24:05.036994      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:24:05.036976      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:24:05.037054      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:24:05.037052      12 shared_informer.go:350] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 02:24:05.037104      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:24:05.037158      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:24:05.038435      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:24:05.042510      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:24:05.043491      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:24:05.044046      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:24:05.062040      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:24:05.063064      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-60k29-hphnj-8xcdl_0e01269a-9453-49e6-a864-9ea28b8883b7 became leader"
I0217 02:24:05.071748      12 openstack.go:424] Setting up informers for Cloud
I0217 02:24:05.071794      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:24:05.072266      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:24:05.072298      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:24:05.072579      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:24:05.072607      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:24:05.073133      12 openstack.go:373] Claiming to support LoadBalancer
I0217 02:24:05.073198      12 controllermanager.go:329] Started "service-lb-controller"
I0217 02:24:05.073263      12 controllermanager.go:310] Starting "node-route-controller"
I0217 02:24:05.073850      12 node_controller.go:176] Sending events to api server.
I0217 02:24:05.073938      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:24:05.074168      12 node_controller.go:185] Waiting for informer caches to sync
I0217 02:24:05.074530      12 controller.go:234] Starting service controller
I0217 02:24:05.075344      12 shared_informer.go:350] "Waiting for caches to sync" controller="service"
W0217 02:24:05.137452      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:24:05.137513      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:24:05.137610      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:24:05.138108      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:24:05.138282      12 shared_informer.go:357] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 02:24:05.138632      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:24:05.139013      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:19:20 +0000 UTC to 2031-02-16 02:19:20 +0000 UTC (now=2026-02-17 02:24:05.138994236 +0000 UTC))"
I0217 02:24:05.139441      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295043\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295043\" (2026-02-17 01:24:02 +0000 UTC to 2027-02-17 01:24:02 +0000 UTC (now=2026-02-17 02:24:05.139426512 +0000 UTC))"
I0217 02:24:05.139707      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295044\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295044\" (2026-02-17 01:24:04 +0000 UTC to 2029-02-17 01:24:04 +0000 UTC (now=2026-02-17 02:24:05.139692997 +0000 UTC))"
I0217 02:24:05.139797      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:19:20 +0000 UTC to 2031-02-16 02:19:20 +0000 UTC (now=2026-02-17 02:24:05.139786208 +0000 UTC))"
I0217 02:24:05.139817      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:19:21 +0000 UTC to 2031-02-16 02:19:21 +0000 UTC (now=2026-02-17 02:24:05.139810438 +0000 UTC))"
I0217 02:24:05.140035      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295043\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295043\" (2026-02-17 01:24:02 +0000 UTC to 2027-02-17 01:24:02 +0000 UTC (now=2026-02-17 02:24:05.140026821 +0000 UTC))"
I0217 02:24:05.140254      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295044\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295044\" (2026-02-17 01:24:04 +0000 UTC to 2029-02-17 01:24:04 +0000 UTC (now=2026-02-17 02:24:05.140244784 +0000 UTC))"
I0217 02:24:05.145697      12 reflector.go:430] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:24:05.147166      12 reflector.go:430] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:24:05.176670      12 shared_informer.go:357] "Caches are synced" controller="service"
I0217 02:24:05.176944      12 controller.go:722] Syncing backends for all LB services.
I0217 02:24:05.176969      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:24:05.177036      12 controller.go:722] Syncing backends for all LB services.
I0217 02:24:05.177079      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:24:05.177237      12 node_controller.go:429] Initializing node kube-60k29-default-worker-mg5f6-9swvp-265g6 with cloud provider
I0217 02:24:05.177512      12 controller.go:722] Syncing backends for all LB services.
I0217 02:24:05.177536      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:24:05.177944      12 node_controller.go:271] Update 3 nodes status took 371.995µs.
I0217 02:24:05.690556      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:24:05.690671      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:24:05.690681      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:24:05.690686      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:24:05.690691      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:24:05.690695      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:24:05.754757      12 controller.go:722] Syncing backends for all LB services.
I0217 02:24:05.754847      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:24:05.837039      12 node_controller.go:474] Successfully initialized node kube-60k29-default-worker-mg5f6-9swvp-265g6 with cloud provider
I0217 02:24:05.837256      12 node_controller.go:429] Initializing node kube-60k29-default-worker-mg5f6-9swvp-hlznr with cloud provider
I0217 02:24:05.840085      12 event.go:389] "Event occurred" object="kube-60k29-default-worker-mg5f6-9swvp-265g6" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:24:06.363479      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:24:06.363559      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:24:06.363571      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:24:06.363580      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:24:06.363590      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:24:06.363600      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:24:06.407082      12 controller.go:722] Syncing backends for all LB services.
I0217 02:24:06.407128      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:24:06.472980      12 node_controller.go:474] Successfully initialized node kube-60k29-default-worker-mg5f6-9swvp-hlznr with cloud provider
I0217 02:24:06.473343      12 node_controller.go:429] Initializing node kube-60k29-hphnj-8xcdl with cloud provider
I0217 02:24:06.473493      12 event.go:389] "Event occurred" object="kube-60k29-default-worker-mg5f6-9swvp-hlznr" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:24:06.861403      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:24:06.861467      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:24:06.861478      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:24:06.861487      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:24:06.861497      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:24:06.861506      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:24:06.884899      12 controller.go:722] Syncing backends for all LB services.
I0217 02:24:06.884948      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:24:06.979371      12 node_controller.go:474] Successfully initialized node kube-60k29-hphnj-8xcdl with cloud provider
I0217 02:24:06.979885      12 event.go:389] "Event occurred" object="kube-60k29-hphnj-8xcdl" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:29:06.418653      12 node_controller.go:271] Update 3 nodes status took 1.239132432s.
I0217 02:31:38.971115      12 controller.go:722] Syncing backends for all LB services.
I0217 02:31:38.971180      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:39.071526      12 controller.go:722] Syncing backends for all LB services.
I0217 02:31:39.072165      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:34:07.590486      12 node_controller.go:271] Update 3 nodes status took 1.170826761s.
I0217 02:39:08.725589      12 node_controller.go:271] Update 3 nodes status took 1.134467527s.
I0217 02:44:10.008009      12 node_controller.go:271] Update 3 nodes status took 1.281143127s.
