2026/02/17 02:40:46 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=27a9fca1-b21d-49e5-978f-62038323b70b,--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:40:46 Now listening for interrupts
I0217 02:40:47.054216      12 serving.go:386] Generated self-signed cert in-memory
I0217 02:40:47.565217      12 serving.go:386] Generated self-signed cert in-memory
W0217 02:40:47.565290      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:40:48.480441      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:40:48.532731      12 controllermanager.go:160] Version: v1.33.1
I0217 02:40:48.657335      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:40:48.657993      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:40:48.658305      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296047\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296046\" (2026-02-17 01:40:46 +0000 UTC to 2027-02-17 01:40:46 +0000 UTC (now=2026-02-17 02:40:48.657583262 +0000 UTC))"
I0217 02:40:48.658049      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:40:48.659033      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:40:48.659033      12 shared_informer.go:350] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 02:40:48.660057      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:40:48.659931      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296048\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296047\" (2026-02-17 01:40:47 +0000 UTC to 2029-02-17 01:40:47 +0000 UTC (now=2026-02-17 02:40:48.659910671 +0000 UTC))"
I0217 02:40:48.660787      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:40:48.661424      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:40:48.662611      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:40:48.665761      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:40:48.666168      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:40:48.669982      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:40:48.692200      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:40:48.692627      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-guq3k-xcf2t-4k852_dca5ed0f-633c-474b-8ced-3d1151a551fc became leader"
I0217 02:40:48.697433      12 openstack.go:424] Setting up informers for Cloud
I0217 02:40:48.697986      12 controllermanager.go:310] Starting "node-route-controller"
W0217 02:40:48.756883      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:40:48.757132      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:40:48.757598      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:40:48.757719      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:40:48.758704      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:40:48.758993      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:40:48.759348      12 node_controller.go:176] Sending events to api server.
I0217 02:40:48.759810      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:40:48.759903      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:40:48.760737      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:40:48.760970      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:40:48.761055      12 openstack.go:373] Claiming to support LoadBalancer
I0217 02:40:48.761159      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:34:38 +0000 UTC to 2031-02-16 02:34:38 +0000 UTC (now=2026-02-17 02:40:48.761129396 +0000 UTC))"
I0217 02:40:48.762046      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296047\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296046\" (2026-02-17 01:40:46 +0000 UTC to 2027-02-17 01:40:46 +0000 UTC (now=2026-02-17 02:40:48.762024888 +0000 UTC))"
I0217 02:40:48.762686      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296048\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296047\" (2026-02-17 01:40:47 +0000 UTC to 2029-02-17 01:40:47 +0000 UTC (now=2026-02-17 02:40:48.762661283 +0000 UTC))"
I0217 02:40:48.762797      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:34:38 +0000 UTC to 2031-02-16 02:34:38 +0000 UTC (now=2026-02-17 02:40:48.762781742 +0000 UTC))"
I0217 02:40:48.762834      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:34:40 +0000 UTC to 2031-02-16 02:34:40 +0000 UTC (now=2026-02-17 02:40:48.762822561 +0000 UTC))"
I0217 02:40:48.763070      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296047\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296046\" (2026-02-17 01:40:46 +0000 UTC to 2027-02-17 01:40:46 +0000 UTC (now=2026-02-17 02:40:48.763060179 +0000 UTC))"
I0217 02:40:48.761415      12 controllermanager.go:329] Started "service-lb-controller"
I0217 02:40:48.764329      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296048\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296047\" (2026-02-17 01:40:47 +0000 UTC to 2029-02-17 01:40:47 +0000 UTC (now=2026-02-17 02:40:48.764313018 +0000 UTC))"
I0217 02:40:48.761539      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:40:48.759791      12 node_controller.go:185] Waiting for informer caches to sync
I0217 02:40:48.761713      12 controller.go:234] Starting service controller
I0217 02:40:48.764798      12 shared_informer.go:350] "Waiting for caches to sync" controller="service"
I0217 02:40:48.764872      12 shared_informer.go:357] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 02:40:48.769750      12 reflector.go:430] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:40:48.770036      12 reflector.go:430] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:40:48.866047      12 shared_informer.go:357] "Caches are synced" controller="service"
I0217 02:40:48.866414      12 controller.go:722] Syncing backends for all LB services.
I0217 02:40:48.866543      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:40:48.866580      12 node_controller.go:429] Initializing node kube-guq3k-xcf2t-4k852 with cloud provider
I0217 02:40:48.866693      12 node_controller.go:271] Update 1 nodes status took 70.79µs.
I0217 02:40:49.577869      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:40:49.577925      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:40:49.577931      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:40:49.577937      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:40:49.577944      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:40:49.577950      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:40:50.011490      12 controller.go:722] Syncing backends for all LB services.
I0217 02:40:50.011608      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:40:50.957679      12 node_controller.go:474] Successfully initialized node kube-guq3k-xcf2t-4k852 with cloud provider
I0217 02:40:50.958343      12 event.go:389] "Event occurred" object="kube-guq3k-xcf2t-4k852" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:40:55.194275      12 controller.go:722] Syncing backends for all LB services.
I0217 02:40:55.194305      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:40:55.194354      12 node_controller.go:429] Initializing node kube-guq3k-default-worker-mbmz6-4zqc4-bmn2f with cloud provider
I0217 02:40:55.830046      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:40:55.830089      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:40:55.830097      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:40:55.830103      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:40:55.830109      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:40:55.830115      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:40:55.886080      12 controller.go:722] Syncing backends for all LB services.
I0217 02:40:55.886543      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:40:56.241946      12 node_controller.go:474] Successfully initialized node kube-guq3k-default-worker-mbmz6-4zqc4-bmn2f with cloud provider
I0217 02:40:56.242427      12 event.go:389] "Event occurred" object="kube-guq3k-default-worker-mbmz6-4zqc4-bmn2f" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:40:59.385312      12 controller.go:722] Syncing backends for all LB services.
I0217 02:40:59.394244      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:40:59.386000      12 node_controller.go:429] Initializing node kube-guq3k-default-worker-mbmz6-4zqc4-knbb5 with cloud provider
I0217 02:40:59.793664      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:40:59.793706      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:40:59.793712      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:40:59.793716      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:40:59.793721      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:40:59.793727      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:40:59.812721      12 controller.go:722] Syncing backends for all LB services.
I0217 02:40:59.812769      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:40:59.858657      12 node_controller.go:474] Successfully initialized node kube-guq3k-default-worker-mbmz6-4zqc4-knbb5 with cloud provider
I0217 02:40:59.859151      12 event.go:389] "Event occurred" object="kube-guq3k-default-worker-mbmz6-4zqc4-knbb5" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:45:50.640974      12 node_controller.go:271] Update 3 nodes status took 1.774115928s.
I0217 02:50:51.741149      12 node_controller.go:271] Update 3 nodes status took 1.099849949s.
I0217 02:54:12.112092      12 controller.go:722] Syncing backends for all LB services.
I0217 02:54:12.112184      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:54:12.230035      12 controller.go:722] Syncing backends for all LB services.
I0217 02:54:12.230878      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:55:53.023702      12 node_controller.go:271] Update 3 nodes status took 1.281601588s.
I0217 03:00:54.139735      12 node_controller.go:271] Update 3 nodes status took 1.115625272s.
I0217 03:05:55.499607      12 node_controller.go:271] Update 3 nodes status took 1.355626812s.
