2026/02/17 02:32:35 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=86452489-5ba0-467b-a2ab-533652052881,--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:32:35 Now listening for interrupts
I0217 02:32:35.541732      12 serving.go:386] Generated self-signed cert in-memory
I0217 02:32:35.594547      12 serving.go:386] Generated self-signed cert in-memory
W0217 02:32:35.594689      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:32:35.951201      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:32:36.009941      12 controllermanager.go:160] Version: v1.34.1
I0217 02:32:36.020012      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:32:36.020288      12 shared_informer.go:349] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 02:32:36.020196      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:32:36.020616      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:32:36.020156      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295555\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295555\" (2026-02-17 01:32:35 +0000 UTC to 2027-02-17 01:32:35 +0000 UTC (now=2026-02-17 02:32:36.020112045 +0000 UTC))"
I0217 02:32:36.021727      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295555\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295555\" (2026-02-17 01:32:35 +0000 UTC to 2029-02-17 01:32:35 +0000 UTC (now=2026-02-17 02:32:36.021704689 +0000 UTC))"
I0217 02:32:36.022073      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:32:36.022650      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:32:36.020297      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:32:36.022736      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:32:36.023363      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:32:36.024027      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:32:36.025255      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:32:36.026824      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:32:36.047532      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:32:36.047884      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-etsjp-cpsxd-khxcz_0af0ad2a-2cd2-4000-bf29-7ef8c3797f3b became leader"
I0217 02:32:36.056537      12 openstack.go:424] Setting up informers for Cloud
I0217 02:32:36.056902      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:32:36.065422      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:32:36.066337      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:32:36.065774      12 node_controller.go:176] Sending events to api server.
I0217 02:32:36.066534      12 node_controller.go:185] Waiting for informer caches to sync
I0217 02:32:36.077499      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:32:36.077695      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:32:36.078622      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:32:36.121671      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:32:36.121891      12 shared_informer.go:356] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 02:32:36.122086      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:26:53 +0000 UTC to 2031-02-16 02:26:53 +0000 UTC (now=2026-02-17 02:32:36.122053606 +0000 UTC))"
I0217 02:32:36.122677      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295555\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295555\" (2026-02-17 01:32:35 +0000 UTC to 2027-02-17 01:32:35 +0000 UTC (now=2026-02-17 02:32:36.122659058 +0000 UTC))"
I0217 02:32:36.123119      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295555\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295555\" (2026-02-17 01:32:35 +0000 UTC to 2029-02-17 01:32:35 +0000 UTC (now=2026-02-17 02:32:36.123100959 +0000 UTC))"
I0217 02:32:36.123408      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:32:36.123632      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:26:52 +0000 UTC to 2031-02-16 02:26:52 +0000 UTC (now=2026-02-17 02:32:36.123614791 +0000 UTC))"
I0217 02:32:36.123702      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:26:53 +0000 UTC to 2031-02-16 02:26:53 +0000 UTC (now=2026-02-17 02:32:36.123687651 +0000 UTC))"
I0217 02:32:36.124037      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295555\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295555\" (2026-02-17 01:32:35 +0000 UTC to 2027-02-17 01:32:35 +0000 UTC (now=2026-02-17 02:32:36.124019312 +0000 UTC))"
I0217 02:32:36.124331      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295555\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295555\" (2026-02-17 01:32:35 +0000 UTC to 2029-02-17 01:32:35 +0000 UTC (now=2026-02-17 02:32:36.124314892 +0000 UTC))"
I0217 02:32:36.264627      12 openstack.go:373] Claiming to support LoadBalancer
I0217 02:32:36.264709      12 controllermanager.go:329] Started "service-lb-controller"
I0217 02:32:36.264717      12 controllermanager.go:310] Starting "node-route-controller"
I0217 02:32:36.265168      12 controller.go:235] Starting service controller
I0217 02:32:36.265238      12 shared_informer.go:349] "Waiting for caches to sync" controller="service"
W0217 02:32:36.293502      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:32:36.293562      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:32:36.293572      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:32:36.299190      12 reflector.go:436] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:32:36.300906      12 reflector.go:436] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:32:36.365512      12 shared_informer.go:356] "Caches are synced" controller="service"
I0217 02:32:36.365616      12 controller.go:723] Syncing backends for all LB services.
I0217 02:32:36.365634      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:32:36.365659      12 controller.go:723] Syncing backends for all LB services.
I0217 02:32:36.365700      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:32:36.365716      12 controller.go:723] Syncing backends for all LB services.
I0217 02:32:36.365724      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:32:36.367130      12 node_controller.go:429] Initializing node kube-etsjp-cpsxd-khxcz with cloud provider
I0217 02:32:36.367452      12 node_controller.go:271] Update 3 nodes status took 297.151µs.
I0217 02:32:36.926469      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:32:36.926860      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:32:36.926891      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:32:36.927163      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:32:36.927192      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:32:36.927217      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:32:36.963960      12 controller.go:723] Syncing backends for all LB services.
I0217 02:32:36.964261      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:32:37.126938      12 node_controller.go:474] Successfully initialized node kube-etsjp-cpsxd-khxcz with cloud provider
I0217 02:32:37.128444      12 node_controller.go:429] Initializing node kube-etsjp-default-worker-r954h-9rx72-7l9tf with cloud provider
I0217 02:32:37.130967      12 event.go:389] "Event occurred" object="kube-etsjp-cpsxd-khxcz" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:32:37.625339      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:32:37.625401      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:32:37.625413      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:32:37.625422      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:32:37.625431      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:32:37.625441      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:32:37.639220      12 controller.go:723] Syncing backends for all LB services.
I0217 02:32:37.639276      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:32:37.691092      12 node_controller.go:474] Successfully initialized node kube-etsjp-default-worker-r954h-9rx72-7l9tf with cloud provider
I0217 02:32:37.691195      12 node_controller.go:429] Initializing node kube-etsjp-default-worker-r954h-9rx72-hwggz with cloud provider
I0217 02:32:37.691894      12 event.go:389] "Event occurred" object="kube-etsjp-default-worker-r954h-9rx72-7l9tf" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:32:38.352345      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:32:38.352383      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:32:38.352389      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:32:38.352393      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:32:38.352397      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:32:38.352402      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:32:38.369844      12 controller.go:723] Syncing backends for all LB services.
I0217 02:32:38.369877      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:32:38.490863      12 node_controller.go:474] Successfully initialized node kube-etsjp-default-worker-r954h-9rx72-hwggz with cloud provider
I0217 02:32:38.491847      12 event.go:389] "Event occurred" object="kube-etsjp-default-worker-r954h-9rx72-hwggz" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:37:37.707227      12 node_controller.go:271] Update 3 nodes status took 1.338466203s.
I0217 02:42:38.676359      12 node_controller.go:271] Update 3 nodes status took 967.953173ms.
I0217 02:43:34.847488      12 controller.go:723] Syncing backends for all LB services.
I0217 02:43:34.848173      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:43:34.957878      12 controller.go:723] Syncing backends for all LB services.
I0217 02:43:34.958709      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:47:39.879021      12 node_controller.go:271] Update 3 nodes status took 1.201245123s.
I0217 02:52:40.852144      12 node_controller.go:271] Update 3 nodes status took 971.856711ms.
