2026/02/16 19:49:23 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=f69b1275-2150-46e4-b113-ca47185ca135,--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:49:23 Now listening for interrupts
I0216 19:49:24.534379      13 serving.go:386] Generated self-signed cert in-memory
I0216 19:49:24.779430      13 serving.go:386] Generated self-signed cert in-memory
W0216 19:49:24.779480      13 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0216 19:49:24.963930      13 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0216 19:49:25.007480      13 controllermanager.go:160] Version: v1.32.1
I0216 19:49:25.015843      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771271364\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771271364\" (2026-02-16 18:49:24 +0000 UTC to 2027-02-16 18:49:24 +0000 UTC (now=2026-02-16 19:49:25.015806731 +0000 UTC))"
I0216 19:49:25.016304      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771271364\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771271364\" (2026-02-16 18:49:24 +0000 UTC to 2027-02-16 18:49:24 +0000 UTC (now=2026-02-16 19:49:25.016227754 +0000 UTC))"
I0216 19:49:25.016360      13 secure_serving.go:213] Serving securely on 127.0.0.1:10258
I0216 19:49:25.016671      13 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0216 19:49:25.016758      13 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0216 19:49:25.016779      13 shared_informer.go:313] Waiting for caches to sync for RequestHeaderAuthRequestController
I0216 19:49:25.016803      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 19:49:25.016811      13 shared_informer.go:313] Waiting for caches to sync for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I0216 19:49:25.017030      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 19:49:25.017098      13 shared_informer.go:313] Waiting for caches to sync for client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file
I0216 19:49:25.017456      13 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0216 19:49:25.018761      13 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0216 19:49:25.020307      13 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0216 19:49:25.022196      13 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0216 19:49:25.032780      13 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0216 19:49:25.033305      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-bmnm8-9g4c7-lsvq8_041cc5a7-c58b-4dad-ae11-2b752a237220 became leader"
I0216 19:49:25.035705      13 openstack.go:424] Setting up informers for Cloud
I0216 19:49:25.035763      13 controllermanager.go:310] Starting "cloud-node-controller"
I0216 19:49:25.036330      13 controllermanager.go:329] Started "cloud-node-controller"
I0216 19:49:25.036371      13 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0216 19:49:25.036819      13 node_controller.go:176] Sending events to api server.
I0216 19:49:25.036964      13 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0216 19:49:25.036978      13 controllermanager.go:310] Starting "service-lb-controller"
I0216 19:49:25.037331      13 node_controller.go:185] Waiting for informer caches to sync
I0216 19:49:25.037611      13 node_lifecycle_controller.go:112] Sending events to api server
I0216 19:49:25.037702      13 openstack.go:373] Claiming to support LoadBalancer
I0216 19:49:25.038328      13 controllermanager.go:329] Started "service-lb-controller"
I0216 19:49:25.038468      13 controllermanager.go:310] Starting "node-route-controller"
I0216 19:49:25.039624      13 controller.go:234] Starting service controller
I0216 19:49:25.039800      13 shared_informer.go:313] Waiting for caches to sync for service
W0216 19:49:25.092877      13 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0216 19:49:25.093003      13 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0216 19:49:25.093021      13 controllermanager.go:317] Skipping "node-route-controller"
I0216 19:49:25.101518      13 reflector.go:376] Caches populated for *v1.Service from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0216 19:49:25.103148      13 reflector.go:376] Caches populated for *v1.Node from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0216 19:49:25.118256      13 shared_informer.go:320] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file
I0216 19:49:25.118449      13 shared_informer.go:320] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I0216 19:49:25.118452      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-15 19:44:02 +0000 UTC to 2031-02-15 19:44:02 +0000 UTC (now=2026-02-16 19:49:25.11843028 +0000 UTC))"
I0216 19:49:25.118523      13 shared_informer.go:320] Caches are synced for RequestHeaderAuthRequestController
I0216 19:49:25.118851      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771271364\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771271364\" (2026-02-16 18:49:24 +0000 UTC to 2027-02-16 18:49:24 +0000 UTC (now=2026-02-16 19:49:25.118836463 +0000 UTC))"
I0216 19:49:25.119330      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771271364\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771271364\" (2026-02-16 18:49:24 +0000 UTC to 2027-02-16 18:49:24 +0000 UTC (now=2026-02-16 19:49:25.119316848 +0000 UTC))"
I0216 19:49:25.119418      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-15 19:44:01 +0000 UTC to 2031-02-15 19:44:01 +0000 UTC (now=2026-02-16 19:49:25.119408508 +0000 UTC))"
I0216 19:49:25.119441      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-15 19:44:02 +0000 UTC to 2031-02-15 19:44:02 +0000 UTC (now=2026-02-16 19:49:25.119434219 +0000 UTC))"
I0216 19:49:25.119589      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771271364\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771271364\" (2026-02-16 18:49:24 +0000 UTC to 2027-02-16 18:49:24 +0000 UTC (now=2026-02-16 19:49:25.11957907 +0000 UTC))"
I0216 19:49:25.120000      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771271364\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771271364\" (2026-02-16 18:49:24 +0000 UTC to 2027-02-16 18:49:24 +0000 UTC (now=2026-02-16 19:49:25.119984633 +0000 UTC))"
I0216 19:49:25.138241      13 node_controller.go:429] Initializing node kube-bmnm8-9g4c7-lsvq8 with cloud provider
I0216 19:49:25.138481      13 node_controller.go:271] Update 2 nodes status took 308.363µs.
I0216 19:49:25.140733      13 shared_informer.go:320] Caches are synced for service
I0216 19:49:25.140825      13 controller.go:722] Syncing backends for all LB services.
I0216 19:49:25.140859      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:49:25.140952      13 controller.go:722] Syncing backends for all LB services.
I0216 19:49:25.140976      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:49:25.702750      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 19:49:25.702806      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 19:49:25.702814      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 19:49:25.702820      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 19:49:25.702831      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 19:49:25.702846      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 19:49:25.741250      13 controller.go:722] Syncing backends for all LB services.
I0216 19:49:25.741292      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:49:25.823642      13 node_controller.go:474] Successfully initialized node kube-bmnm8-9g4c7-lsvq8 with cloud provider
I0216 19:49:25.823702      13 node_controller.go:429] Initializing node kube-bmnm8-default-worker-qzfvs-zh5sz-mwqpq with cloud provider
I0216 19:49:25.824470      13 event.go:389] "Event occurred" object="kube-bmnm8-9g4c7-lsvq8" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 19:49:26.225065      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 19:49:26.225088      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 19:49:26.225094      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 19:49:26.225099      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 19:49:26.225105      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 19:49:26.225111      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 19:49:26.241794      13 controller.go:722] Syncing backends for all LB services.
I0216 19:49:26.243169      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:49:26.306815      13 node_controller.go:474] Successfully initialized node kube-bmnm8-default-worker-qzfvs-zh5sz-mwqpq with cloud provider
I0216 19:49:26.309442      13 event.go:389] "Event occurred" object="kube-bmnm8-default-worker-qzfvs-zh5sz-mwqpq" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 19:49:29.255350      13 node_controller.go:429] Initializing node kube-bmnm8-default-worker-qzfvs-zh5sz-v8lfc with cloud provider
I0216 19:49:29.256287      13 controller.go:722] Syncing backends for all LB services.
I0216 19:49:29.256296      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:49:29.619656      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 19:49:29.619924      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 19:49:29.619934      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 19:49:29.619942      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 19:49:29.620213      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 19:49:29.620222      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 19:49:30.195303      13 controller.go:722] Syncing backends for all LB services.
I0216 19:49:30.195357      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:49:30.421537      13 node_controller.go:474] Successfully initialized node kube-bmnm8-default-worker-qzfvs-zh5sz-v8lfc with cloud provider
I0216 19:49:30.421608      13 event.go:389] "Event occurred" object="kube-bmnm8-default-worker-qzfvs-zh5sz-v8lfc" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 19:54:26.265035      13 node_controller.go:271] Update 3 nodes status took 1.125676041s.
I0216 19:59:27.572919      13 node_controller.go:271] Update 3 nodes status took 1.306831211s.
