2026/02/17 02:31:47 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=c6d4c890-1bf5-457b-8ba2-01277cc37094,--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:31:47 Now listening for interrupts
I0217 02:31:47.711472      13 serving.go:386] Generated self-signed cert in-memory
I0217 02:31:48.111201      13 serving.go:386] Generated self-signed cert in-memory
W0217 02:31:48.111255      13 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:31:48.521429      13 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:31:48.579208      13 controllermanager.go:160] Version: v1.33.1
I0217 02:31:48.585556      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295507\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295507\" (2026-02-17 01:31:47 +0000 UTC to 2027-02-17 01:31:47 +0000 UTC (now=2026-02-17 02:31:48.585519296 +0000 UTC))"
I0217 02:31:48.585682      13 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:31:48.585798      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:31:48.585832      13 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:31:48.585835      13 shared_informer.go:350] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 02:31:48.585960      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:31:48.585973      13 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:31:48.585734      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295508\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295508\" (2026-02-17 01:31:48 +0000 UTC to 2029-02-17 01:31:48 +0000 UTC (now=2026-02-17 02:31:48.585723447 +0000 UTC))"
I0217 02:31:48.586020      13 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:31:48.586206      13 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:31:48.587833      13 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:31:48.588362      13 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:31:48.588601      13 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:31:48.588840      13 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:31:48.604202      13 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:31:48.605040      13 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-iwosr-dfb6b-hs8kf_7c21740f-e407-4558-a314-1ff14baccf67 became leader"
I0217 02:31:48.610108      13 openstack.go:424] Setting up informers for Cloud
I0217 02:31:48.610170      13 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:31:48.611230      13 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:31:48.611278      13 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:31:48.611572      13 node_controller.go:176] Sending events to api server.
I0217 02:31:48.611699      13 node_controller.go:185] Waiting for informer caches to sync
I0217 02:31:48.612339      13 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:31:48.612373      13 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:31:48.613188      13 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:31:48.613208      13 openstack.go:373] Claiming to support LoadBalancer
I0217 02:31:48.613450      13 controllermanager.go:329] Started "service-lb-controller"
I0217 02:31:48.613486      13 controllermanager.go:310] Starting "node-route-controller"
I0217 02:31:48.613866      13 controller.go:234] Starting service controller
I0217 02:31:48.614050      13 shared_informer.go:350] "Waiting for caches to sync" controller="service"
W0217 02:31:48.673883      13 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:31:48.674135      13 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:31:48.674281      13 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:31:48.679778      13 reflector.go:430] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:31:48.682344      13 reflector.go:430] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:31:48.686581      13 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:31:48.687010      13 shared_informer.go:357] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 02:31:48.687010      13 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:31:48.687615      13 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:26:20 +0000 UTC to 2031-02-16 02:26:20 +0000 UTC (now=2026-02-17 02:31:48.687587333 +0000 UTC))"
I0217 02:31:48.688164      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295507\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295507\" (2026-02-17 01:31:47 +0000 UTC to 2027-02-17 01:31:47 +0000 UTC (now=2026-02-17 02:31:48.688148478 +0000 UTC))"
I0217 02:31:48.688625      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295508\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295508\" (2026-02-17 01:31:48 +0000 UTC to 2029-02-17 01:31:48 +0000 UTC (now=2026-02-17 02:31:48.688609642 +0000 UTC))"
I0217 02:31:48.688908      13 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:26:18 +0000 UTC to 2031-02-16 02:26:18 +0000 UTC (now=2026-02-17 02:31:48.688836754 +0000 UTC))"
I0217 02:31:48.689044      13 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:26:20 +0000 UTC to 2031-02-16 02:26:20 +0000 UTC (now=2026-02-17 02:31:48.689032666 +0000 UTC))"
I0217 02:31:48.689426      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295507\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295507\" (2026-02-17 01:31:47 +0000 UTC to 2027-02-17 01:31:47 +0000 UTC (now=2026-02-17 02:31:48.689402419 +0000 UTC))"
I0217 02:31:48.689812      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295508\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295508\" (2026-02-17 01:31:48 +0000 UTC to 2029-02-17 01:31:48 +0000 UTC (now=2026-02-17 02:31:48.689799033 +0000 UTC))"
I0217 02:31:48.713131      13 node_controller.go:429] Initializing node kube-iwosr-default-worker-ljpxk-4dfjp-79njc with cloud provider
I0217 02:31:48.714068      13 node_controller.go:271] Update 3 nodes status took 915.688µs.
I0217 02:31:48.714282      13 shared_informer.go:357] "Caches are synced" controller="service"
I0217 02:31:48.714853      13 controller.go:722] Syncing backends for all LB services.
I0217 02:31:48.715003      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:48.715048      13 controller.go:722] Syncing backends for all LB services.
I0217 02:31:48.715061      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:48.715078      13 controller.go:722] Syncing backends for all LB services.
I0217 02:31:48.715088      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:49.225009      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:31:49.225082      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:31:49.225093      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:31:49.225101      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:31:49.225110      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:31:49.225119      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:31:49.355462      13 controller.go:722] Syncing backends for all LB services.
I0217 02:31:49.355504      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:49.402196      13 node_controller.go:474] Successfully initialized node kube-iwosr-default-worker-ljpxk-4dfjp-79njc with cloud provider
I0217 02:31:49.402289      13 node_controller.go:429] Initializing node kube-iwosr-default-worker-ljpxk-4dfjp-c8lbf with cloud provider
I0217 02:31:49.403186      13 event.go:389] "Event occurred" object="kube-iwosr-default-worker-ljpxk-4dfjp-79njc" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:31:49.883914      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:31:49.884036      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:31:49.884110      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:31:49.884117      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:31:49.884126      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:31:49.884132      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:31:49.901761      13 controller.go:722] Syncing backends for all LB services.
I0217 02:31:49.902039      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:49.921746      13 node_controller.go:474] Successfully initialized node kube-iwosr-default-worker-ljpxk-4dfjp-c8lbf with cloud provider
I0217 02:31:49.922623      13 event.go:389] "Event occurred" object="kube-iwosr-default-worker-ljpxk-4dfjp-c8lbf" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:31:49.923649      13 node_controller.go:429] Initializing node kube-iwosr-dfb6b-hs8kf with cloud provider
I0217 02:31:50.436695      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:31:50.436769      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:31:50.436781      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:31:50.436791      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:31:50.436801      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:31:50.436811      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:31:50.462176      13 controller.go:722] Syncing backends for all LB services.
I0217 02:31:50.462209      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:50.550690      13 node_controller.go:474] Successfully initialized node kube-iwosr-dfb6b-hs8kf with cloud provider
I0217 02:31:50.565505      13 event.go:389] "Event occurred" object="kube-iwosr-dfb6b-hs8kf" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:36:49.960665      13 node_controller.go:271] Update 3 nodes status took 1.245482389s.
I0217 02:41:50.973285      13 node_controller.go:271] Update 3 nodes status took 998.455789ms.
I0217 02:46:52.126422      13 node_controller.go:271] Update 3 nodes status took 1.150889533s.
I0217 02:50:38.746982      13 controller.go:722] Syncing backends for all LB services.
I0217 02:50:38.747038      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:50:38.823508      13 controller.go:722] Syncing backends for all LB services.
I0217 02:50:38.823725      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:51:53.157774      13 node_controller.go:271] Update 3 nodes status took 1.030166638s.
I0217 02:56:54.360783      13 node_controller.go:271] Update 3 nodes status took 1.201811652s.
