2026/02/16 19: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=19465a13-6a03-43b5-8638-3ae0ba97712d,--cloud-provider=openstack,--use-service-account-credentials=false,--controllers=cloud-node,cloud-node-lifecycle,route,service,--bind-address=127.0.0.1
2026/02/16 19:48:24 Now listening for interrupts
I0216 19:48:25.689936      11 serving.go:386] Generated self-signed cert in-memory
I0216 19:48:25.903078      11 serving.go:386] Generated self-signed cert in-memory
W0216 19:48:25.903130      11 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0216 19:48:26.230435      11 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0216 19:48:26.279185      11 controllermanager.go:160] Version: v1.33.1
I0216 19:48:26.287677      11 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771271305\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771271305\" (2026-02-16 18:48:25 +0000 UTC to 2027-02-16 18:48:25 +0000 UTC (now=2026-02-16 19:48:26.287647955 +0000 UTC))"
I0216 19:48:26.287860      11 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771271306\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771271306\" (2026-02-16 18:48:25 +0000 UTC to 2029-02-16 18:48:25 +0000 UTC (now=2026-02-16 19:48:26.287850999 +0000 UTC))"
I0216 19:48:26.287901      11 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0216 19:48:26.287808      11 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0216 19:48:26.288083      11 shared_informer.go:350] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0216 19:48:26.288299      11 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0216 19:48:26.288337      11 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 19:48:26.288347      11 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 19:48:26.288928      11 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0216 19:48:26.288165      11 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 19:48:26.289276      11 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 19:48:26.291818      11 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 19:48:26.293430      11 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 19:48:26.293999      11 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 19:48:26.302838      11 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0216 19:48:26.303210      11 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-mntua-2k5mb-q9cpm_2187d0d3-ea28-492d-830e-ea38bfc07fb7 became leader"
I0216 19:48:26.305856      11 openstack.go:424] Setting up informers for Cloud
I0216 19:48:26.305944      11 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0216 19:48:26.306359      11 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0216 19:48:26.306385      11 controllermanager.go:310] Starting "service-lb-controller"
I0216 19:48:26.307051      11 openstack.go:373] Claiming to support LoadBalancer
I0216 19:48:26.307153      11 controllermanager.go:329] Started "service-lb-controller"
I0216 19:48:26.307173      11 controllermanager.go:310] Starting "node-route-controller"
I0216 19:48:26.307406      11 node_lifecycle_controller.go:112] Sending events to api server
I0216 19:48:26.308002      11 controller.go:234] Starting service controller
I0216 19:48:26.308078      11 shared_informer.go:350] "Waiting for caches to sync" controller="service"
W0216 19:48:26.364649      11 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0216 19:48:26.364771      11 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0216 19:48:26.364876      11 controllermanager.go:317] Skipping "node-route-controller"
I0216 19:48:26.364905      11 controllermanager.go:310] Starting "cloud-node-controller"
I0216 19:48:26.365453      11 controllermanager.go:329] Started "cloud-node-controller"
I0216 19:48:26.365762      11 node_controller.go:176] Sending events to api server.
I0216 19:48:26.365954      11 node_controller.go:185] Waiting for informer caches to sync
I0216 19:48:26.371180      11 reflector.go:430] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 19:48:26.371842      11 reflector.go:430] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 19:48:26.389190      11 shared_informer.go:357] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0216 19:48:26.389427      11 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 19:48:26.389759      11 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 19:48:26.389838      11 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-15 19:43:21 +0000 UTC to 2031-02-15 19:43:21 +0000 UTC (now=2026-02-16 19:48:26.389805519 +0000 UTC))"
I0216 19:48:26.390705      11 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771271305\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771271305\" (2026-02-16 18:48:25 +0000 UTC to 2027-02-16 18:48:25 +0000 UTC (now=2026-02-16 19:48:26.390675765 +0000 UTC))"
I0216 19:48:26.391293      11 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771271306\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771271306\" (2026-02-16 18:48:25 +0000 UTC to 2029-02-16 18:48:25 +0000 UTC (now=2026-02-16 19:48:26.391262088 +0000 UTC))"
I0216 19:48:26.391589      11 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-15 19:43:21 +0000 UTC to 2031-02-15 19:43:21 +0000 UTC (now=2026-02-16 19:48:26.391566621 +0000 UTC))"
I0216 19:48:26.391673      11 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-15 19:43:22 +0000 UTC to 2031-02-15 19:43:22 +0000 UTC (now=2026-02-16 19:48:26.391657738 +0000 UTC))"
I0216 19:48:26.392304      11 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771271305\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771271305\" (2026-02-16 18:48:25 +0000 UTC to 2027-02-16 18:48:25 +0000 UTC (now=2026-02-16 19:48:26.392288435 +0000 UTC))"
I0216 19:48:26.392570      11 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771271306\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771271306\" (2026-02-16 18:48:25 +0000 UTC to 2029-02-16 18:48:25 +0000 UTC (now=2026-02-16 19:48:26.392557785 +0000 UTC))"
I0216 19:48:26.408943      11 shared_informer.go:357] "Caches are synced" controller="service"
I0216 19:48:26.409140      11 controller.go:722] Syncing backends for all LB services.
I0216 19:48:26.409160      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:48:26.466291      11 node_controller.go:429] Initializing node kube-mntua-2k5mb-q9cpm with cloud provider
I0216 19:48:26.466944      11 node_controller.go:271] Update 1 nodes status took 607.005µs.
I0216 19:48:26.932962      11 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 19:48:26.933365      11 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 19:48:26.933490      11 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 19:48:26.933608      11 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 19:48:26.933670      11 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 19:48:26.933758      11 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 19:48:26.964511      11 controller.go:722] Syncing backends for all LB services.
I0216 19:48:26.968722      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:48:27.031842      11 node_controller.go:474] Successfully initialized node kube-mntua-2k5mb-q9cpm with cloud provider
I0216 19:48:27.031971      11 event.go:389] "Event occurred" object="kube-mntua-2k5mb-q9cpm" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 19:48:35.246856      11 node_controller.go:429] Initializing node kube-mntua-default-worker-cl7mh-c9j4p-dg2rv with cloud provider
I0216 19:48:35.248171      11 controller.go:722] Syncing backends for all LB services.
I0216 19:48:35.248216      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:48:35.775599      11 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 19:48:35.775655      11 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 19:48:35.775662      11 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 19:48:35.775667      11 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 19:48:35.775673      11 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 19:48:35.775679      11 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 19:48:35.806387      11 controller.go:722] Syncing backends for all LB services.
I0216 19:48:35.806491      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:48:35.816442      11 node_controller.go:474] Successfully initialized node kube-mntua-default-worker-cl7mh-c9j4p-dg2rv with cloud provider
I0216 19:48:35.816793      11 event.go:389] "Event occurred" object="kube-mntua-default-worker-cl7mh-c9j4p-dg2rv" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 19:48:39.195960      11 node_controller.go:429] Initializing node kube-mntua-default-worker-cl7mh-c9j4p-qgpqr with cloud provider
I0216 19:48:39.197096      11 controller.go:722] Syncing backends for all LB services.
I0216 19:48:39.197162      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:48:39.532222      11 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 19:48:39.532263      11 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 19:48:39.532269      11 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 19:48:39.532273      11 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 19:48:39.532278      11 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 19:48:39.532283      11 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 19:48:39.559856      11 controller.go:722] Syncing backends for all LB services.
I0216 19:48:39.559930      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:48:39.579663      11 node_controller.go:474] Successfully initialized node kube-mntua-default-worker-cl7mh-c9j4p-qgpqr with cloud provider
I0216 19:48:39.580047      11 event.go:389] "Event occurred" object="kube-mntua-default-worker-cl7mh-c9j4p-qgpqr" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 19:53:27.548165      11 node_controller.go:271] Update 3 nodes status took 1.080198221s.
I0216 19:55:50.304880      11 controller.go:722] Syncing backends for all LB services.
I0216 19:55:50.304923      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:55:50.347218      11 controller.go:722] Syncing backends for all LB services.
I0216 19:55:50.347291      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:58:28.482329      11 node_controller.go:271] Update 3 nodes status took 933.538503ms.
I0216 20:03:29.469816      11 node_controller.go:271] Update 3 nodes status took 987.213721ms.
I0216 20:08:30.633811      11 node_controller.go:271] Update 3 nodes status took 1.16355546s.
I0216 20:13:31.668379      11 node_controller.go:271] Update 3 nodes status took 1.034236653s.
