2026/02/17 02:35:15 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=a3f0f2aa-e6d4-4d44-b2d5-e1bcffab206c,--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:35:15 Now listening for interrupts
I0217 02:35:15.762250      12 serving.go:386] Generated self-signed cert in-memory
I0217 02:35:15.852785      12 serving.go:386] Generated self-signed cert in-memory
W0217 02:35:15.852846      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:35:16.291319      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:35:16.354550      12 controllermanager.go:160] Version: v1.34.1
I0217 02:35:16.363224      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295715\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295715\" (2026-02-17 01:35:15 +0000 UTC to 2027-02-17 01:35:15 +0000 UTC (now=2026-02-17 02:35:16.363184705 +0000 UTC))"
I0217 02:35:16.363871      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295716\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295716\" (2026-02-17 01:35:15 +0000 UTC to 2029-02-17 01:35:15 +0000 UTC (now=2026-02-17 02:35:16.36385617 +0000 UTC))"
I0217 02:35:16.363933      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:35:16.364566      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:35:16.365444      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:35:16.365494      12 shared_informer.go:349] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 02:35:16.366335      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:35:16.369550      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:35:16.369843      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:35:16.369999      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:35:16.370124      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:35:16.385719      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:35:16.387160      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:35:16.388021      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:35:16.402511      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:35:16.402667      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-xv3bi-xbmhg-xdwb4_691f8ef1-0464-4dbc-9190-367b1045f7eb became leader"
I0217 02:35:16.406502      12 openstack.go:424] Setting up informers for Cloud
I0217 02:35:16.406885      12 controllermanager.go:310] Starting "node-route-controller"
I0217 02:35:16.466772      12 shared_informer.go:356] "Caches are synced" controller="RequestHeaderAuthRequestController"
W0217 02:35:16.470697      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:35:16.471465      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:35:16.471845      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:35:16.472152      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:35:16.471278      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:35:16.471199      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:35:16.473151      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:13 +0000 UTC to 2031-02-16 02:29:13 +0000 UTC (now=2026-02-17 02:35:16.473123036 +0000 UTC))"
I0217 02:35:16.473752      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295715\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295715\" (2026-02-17 01:35:15 +0000 UTC to 2027-02-17 01:35:15 +0000 UTC (now=2026-02-17 02:35:16.473737547 +0000 UTC))"
I0217 02:35:16.474228      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295716\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295716\" (2026-02-17 01:35:15 +0000 UTC to 2029-02-17 01:35:15 +0000 UTC (now=2026-02-17 02:35:16.474212089 +0000 UTC))"
I0217 02:35:16.474399      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:13 +0000 UTC to 2031-02-16 02:29:13 +0000 UTC (now=2026-02-17 02:35:16.474388151 +0000 UTC))"
I0217 02:35:16.474558      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:15 +0000 UTC to 2031-02-16 02:29:15 +0000 UTC (now=2026-02-17 02:35:16.474546552 +0000 UTC))"
I0217 02:35:16.475182      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295715\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295715\" (2026-02-17 01:35:15 +0000 UTC to 2027-02-17 01:35:15 +0000 UTC (now=2026-02-17 02:35:16.475170123 +0000 UTC))"
I0217 02:35:16.475692      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295716\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295716\" (2026-02-17 01:35:15 +0000 UTC to 2029-02-17 01:35:15 +0000 UTC (now=2026-02-17 02:35:16.475678257 +0000 UTC))"
I0217 02:35:16.486423      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:35:16.486480      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:35:16.487491      12 node_controller.go:176] Sending events to api server.
I0217 02:35:16.487999      12 node_controller.go:185] Waiting for informer caches to sync
I0217 02:35:16.496515      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:35:16.496558      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:35:16.497820      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:35:16.516756      12 openstack.go:373] Claiming to support LoadBalancer
I0217 02:35:16.517513      12 controllermanager.go:329] Started "service-lb-controller"
I0217 02:35:16.517966      12 controller.go:235] Starting service controller
I0217 02:35:16.518000      12 shared_informer.go:349] "Waiting for caches to sync" controller="service"
I0217 02:35:16.522933      12 reflector.go:436] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:35:16.523771      12 reflector.go:436] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:35:16.588947      12 node_controller.go:429] Initializing node kube-xv3bi-xbmhg-xdwb4 with cloud provider
I0217 02:35:16.589841      12 node_controller.go:271] Update 1 nodes status took 876.218µs.
I0217 02:35:16.618896      12 shared_informer.go:356] "Caches are synced" controller="service"
I0217 02:35:16.619497      12 controller.go:723] Syncing backends for all LB services.
I0217 02:35:16.619600      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:35:17.145197      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:35:17.145497      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:35:17.145662      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:35:17.145774      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:35:17.146299      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:35:17.146429      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:35:17.213517      12 controller.go:723] Syncing backends for all LB services.
I0217 02:35:17.220412      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:35:17.364782      12 node_controller.go:474] Successfully initialized node kube-xv3bi-xbmhg-xdwb4 with cloud provider
I0217 02:35:17.374768      12 event.go:389] "Event occurred" object="kube-xv3bi-xbmhg-xdwb4" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:35:29.625626      12 node_controller.go:429] Initializing node kube-xv3bi-default-worker-6rwhs-g6z6l-cltcq with cloud provider
I0217 02:35:29.629727      12 controller.go:723] Syncing backends for all LB services.
I0217 02:35:29.629759      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:35:29.901041      12 controller.go:723] Syncing backends for all LB services.
I0217 02:35:29.901134      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:35:30.249819      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:35:30.249879      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:35:30.249890      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:35:30.249899      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:35:30.249909      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:35:30.249918      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:35:30.531290      12 controller.go:723] Syncing backends for all LB services.
I0217 02:35:30.531340      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:35:31.077678      12 node_controller.go:474] Successfully initialized node kube-xv3bi-default-worker-6rwhs-g6z6l-cltcq with cloud provider
I0217 02:35:31.077861      12 node_controller.go:429] Initializing node kube-xv3bi-default-worker-6rwhs-g6z6l-kpmxt with cloud provider
I0217 02:35:31.080308      12 event.go:389] "Event occurred" object="kube-xv3bi-default-worker-6rwhs-g6z6l-cltcq" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:35:31.511612      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:35:31.511780      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:35:31.511808      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:35:31.511946      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:35:31.512086      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:35:31.512111      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:35:32.163392      12 controller.go:723] Syncing backends for all LB services.
I0217 02:35:32.163527      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:35:32.357171      12 node_controller.go:474] Successfully initialized node kube-xv3bi-default-worker-6rwhs-g6z6l-kpmxt with cloud provider
I0217 02:35:32.357612      12 event.go:389] "Event occurred" object="kube-xv3bi-default-worker-6rwhs-g6z6l-kpmxt" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:40:17.847406      12 node_controller.go:271] Update 3 nodes status took 1.257160216s.
I0217 02:45:18.919136      12 node_controller.go:271] Update 3 nodes status took 1.070940833s.
I0217 02:47:11.520074      12 controller.go:723] Syncing backends for all LB services.
I0217 02:47:11.520124      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:47:11.645691      12 controller.go:723] Syncing backends for all LB services.
I0217 02:47:11.645741      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:50:19.957190      12 node_controller.go:271] Update 3 nodes status took 1.037465776s.
I0217 02:55:20.972906      12 node_controller.go:271] Update 3 nodes status took 1.014154413s.
I0217 03:00:22.090811      12 node_controller.go:271] Update 3 nodes status took 1.117228197s.
