Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

[bug] CIAB 8.0.0 creation of loadbalancer ends with provisioning status error #1151

Open
kayamax opened this issue Sep 26, 2024 · 0 comments
Labels
bug Something isn't working

Comments

@kayamax
Copy link

kayamax commented Sep 26, 2024

OSISM release version

8.0.0

What's the problem?

I have just greped from log files all lines with uuid of loadbalancer , I hope this helps:

root@manager:/home/dragon# grep -B5 -A5 -rn d2063e0e-ff32-49e8-acec-3f6b401f1793 /var/lib/docker/volumes/kolla_logs/_data/octavia/**octavia-api.log**

4928-2024-09-26 14:47:52.943 733 WARNING keystoneauth.session [None req-728b2aea-6a7e-4458-9a7c-c1ce9909503b - ed6fb2a580b64660959af9ed3d758689 - - default default] Failure: Unable to establish connection to https://api.in-a-box.cloud:5000/v3/auth/tokens: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response')). Retrying in 0.5s.3 retries left: keystoneauth1.exceptions.connection.ConnectFailure: Unable to establish connection to https://api.in-a-box.cloud:5000/v3/auth/tokens: ('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))
4929-2024-09-26 15:25:02.954 733 INFO octavia.api.v2.controllers.load_balancer [None req-caec954d-8b42-4a0c-8a6c-649bbe87f5e6 - 04b3858f23984a109b2a5793263982bd - - 1b06de491a7d4209afe7fa13952d056d 1b06de491a7d4209afe7fa13952d056d] Sending delete Load Balancer 42656c3f-7432-4a08-949c-8e1aadb8fc71 to provider amphora
4930-2024-09-26 15:26:09.844 733 WARNING openstack [None req-b6ee4c7b-b33a-464a-afdf-223481674925 - 04b3858f23984a109b2a5793263982bd - - 1b06de491a7d4209afe7fa13952d056d 1b06de491a7d4209afe7fa13952d056d] Disabling service 'block-storage': Encountered an exception attempting to process config for project 'cinder' (service type 'block-storage'): no such option valid_interfaces in group [cinder]: oslo_config.cfg.NoSuchOptError: no such option valid_interfaces in group [cinder]
4931-2024-09-26 15:26:09.845 733 WARNING openstack [None req-b6ee4c7b-b33a-464a-afdf-223481674925 - 04b3858f23984a109b2a5793263982bd - - 1b06de491a7d4209afe7fa13952d056d 1b06de491a7d4209afe7fa13952d056d] Disabling service 'compute': Encountered an exception attempting to process config for project 'nova' (service type 'compute'): no such option valid_interfaces in group [nova]: oslo_config.cfg.NoSuchOptError: no such option valid_interfaces in group [nova]
4932-2024-09-26 15:26:09.845 733 WARNING openstack [None req-b6ee4c7b-b33a-464a-afdf-223481674925 - 04b3858f23984a109b2a5793263982bd - - 1b06de491a7d4209afe7fa13952d056d 1b06de491a7d4209afe7fa13952d056d] Disabling service 'image': Encountered an exception attempting to process config for project 'glance' (service type 'image'): no such option valid_interfaces in group [glance]: oslo_config.cfg.NoSuchOptError: no such option valid_interfaces in group [glance]
4933:2024-09-26 15:26:10.538 733 INFO octavia.api.drivers.amphora_driver.v2.driver [None req-b6ee4c7b-b33a-464a-afdf-223481674925 - 04b3858f23984a109b2a5793263982bd - - 1b06de491a7d4209afe7fa13952d056d 1b06de491a7d4209afe7fa13952d056d] Amphora provider created VIP port ac5a5eb5-8a06-4d46-8283-a69c9999233a for load balancer d2063e0e-ff32-49e8-acec-3f6b401f1793.
4934:2024-09-26 15:26:10.544 733 INFO octavia.api.v2.controllers.load_balancer [None req-b6ee4c7b-b33a-464a-afdf-223481674925 - 04b3858f23984a109b2a5793263982bd - - 1b06de491a7d4209afe7fa13952d056d 1b06de491a7d4209afe7fa13952d056d] Sending create Load Balancer d2063e0e-ff32-49e8-acec-3f6b401f1793 to provider amphora

root@manager:/home/dragon# grep -B5 -A5 -rn d2063e0e-ff32-49e8-acec-3f6b401f1793 /var/lib/docker/volumes/kolla_logs/_data/octavia/**octavia-worker.log**

691:2024-09-26 15:26:10.547 731 INFO octavia.controller.queue.v2.endpoints [-] Creating load balancer 'd2063e0e-ff32-49e8-acec-3f6b401f1793'...
692-2024-09-26 15:26:10.862 731 INFO octavia.network.drivers.neutron.allowed_address_pairs [None req-c5fcc541-3cb5-4045-894d-ea6662b0f9f2 - 04b3858f23984a109b2a5793263982bd - - - -] Port ac5a5eb5-8a06-4d46-8283-a69c9999233a already exists. Nothing to be done.
693:2024-09-26 15:26:10.865 731 INFO octavia.controller.worker.v2.tasks.network_tasks [None req-c5fcc541-3cb5-4045-894d-ea6662b0f9f2 - 04b3858f23984a109b2a5793263982bd - - - -] Allocated vip with port id ac5a5eb5-8a06-4d46-8283-a69c9999233a, subnet id 329187ea-6d32-4741-a343-cbfaaaa5ce9a, ip address 192.168.200.98 for load balancer d2063e0e-ff32-49e8-acec-3f6b401f1793
694:2024-09-26 15:26:10.886 731 INFO octavia.controller.worker.v2.tasks.database_tasks [None req-c5fcc541-3cb5-4045-894d-ea6662b0f9f2 - 04b3858f23984a109b2a5793263982bd - - - -] Updated vip with port id ac5a5eb5-8a06-4d46-8283-a69c9999233a, subnet id 329187ea-6d32-4741-a343-cbfaaaa5ce9a, ip address 192.168.200.98 for load balancer d2063e0e-ff32-49e8-acec-3f6b401f1793
695:2024-09-26 15:26:11.757 731 INFO octavia.controller.worker.v2.tasks.network_tasks [None req-c5fcc541-3cb5-4045-894d-ea6662b0f9f2 - 04b3858f23984a109b2a5793263982bd - - - -] Set up VIP SG 822c4582-7616-43af-be6e-62cfa6fccdc5 for load balancer d2063e0e-ff32-49e8-acec-3f6b401f1793 complete
696:2024-09-26 15:26:11.844 731 INFO octavia.controller.worker.v2.tasks.network_tasks [None req-c5fcc541-3cb5-4045-894d-ea6662b0f9f2 - 04b3858f23984a109b2a5793263982bd - - - -] Got subnet 329187ea-6d32-4741-a343-cbfaaaa5ce9a for load balancer d2063e0e-ff32-49e8-acec-3f6b401f1793
697:2024-09-26 15:26:11.861 731 INFO octavia.controller.worker.v2.tasks.database_tasks [None req-c5fcc541-3cb5-4045-894d-ea6662b0f9f2 - 04b3858f23984a109b2a5793263982bd - - - -] Created Amphora 977bafb6-d243-4601-983e-3e9661dcac46 in DB for load balancer d2063e0e-ff32-49e8-acec-3f6b401f1793
698-2024-09-26 15:26:11.967 731 INFO octavia.certificates.generator.local [None req-c5fcc541-3cb5-4045-894d-ea6662b0f9f2 - 04b3858f23984a109b2a5793263982bd - - - -] Signing a certificate request using OpenSSL locally.
699-2024-09-26 15:26:11.967 731 INFO octavia.certificates.generator.local [None req-c5fcc541-3cb5-4045-894d-ea6662b0f9f2 - 04b3858f23984a109b2a5793263982bd - - - -] Using CA Certificate from config.
700-2024-09-26 15:26:11.968 731 INFO octavia.certificates.generator.local [None req-c5fcc541-3cb5-4045-894d-ea6662b0f9f2 - 04b3858f23984a109b2a5793263982bd - - - -] Using CA Private Key from config.
701-2024-09-26 15:26:11.968 731 INFO octavia.certificates.generator.local [None req-c5fcc541-3cb5-4045-894d-ea6662b0f9f2 - 04b3858f23984a109b2a5793263982bd - - - -] Using CA Private Key Passphrase from config.
702-2024-09-26 15:26:14.303 731 INFO octavia.controller.worker.v2.tasks.compute_tasks [None req-c5fcc541-3cb5-4045-894d-ea6662b0f9f2 - 04b3858f23984a109b2a5793263982bd - - - -] Server created with id: 742b2fe4-1c69-4e5d-8189-73188b26e1d6 for amphora id: 977bafb6-d243-4601-983e-3e9661dcac46

root@manager:/home/dragon# grep -B5 -A5 -rn d2063e0e-ff32-49e8-acec-3f6b401f1793 /var/lib/docker/volumes/kolla_logs/_data/octavia/**octavia-api-access.log**

77223-- - - [26/Sep/2024:15:36:29 +0000] "GET / HTTP/1.1" 200 4149 4820 "-" "curl-healthcheck"
77224:192.168.16.254 - - [26/Sep/2024:15:36:30 +0000] "GET /v2.0/lbaas/loadbalancers/d2063e0e-ff32-49e8-acec-3f6b401f1793 HTTP/1.1" 200 744 59654 "-" "openstacksdk/3.0.0 keystoneauth1/5.6.0 python-requests/2.31.0 CPython/3.10.12"
77225-192.168.16.254 - - [26/Sep/2024:15:36:30 +0000] "GET /v2.0/lbaas/loadbalancers?project_id=04b3858f23984a109b2a5793263982bd HTTP/1.1" 200 774 54671 "-" "openstacksdk/3.0.0 keystoneauth1/5.6.0 python-requests/2.31.0 CPython/3.10.12"
77226-192.168.16.254 - - [26/Sep/2024:15:36:30 +0000] "GET /v2.0/lbaas/loadbalancers HTTP/1.1" 200 774 77713 "-" "gophercloud/v1.5.0"
77227-192.168.16.254 - - [26/Sep/2024:15:36:30 +0000] "GET /v2.0/octavia/amphorae HTTP/1.1" 200 669 19349 "-" "gophercloud/v1.5.0"
77228-192.168.16.254 - - [26/Sep/2024:15:36:30 +0000] "GET /v2.0/lbaas/pools HTTP/1.1" 200 32 16454 "-" "gophercloud/v1.5.0"
77229:192.168.16.254 - - [26/Sep/2024:15:36:32 +0000] "GET /v2.0/lbaas/loadbalancers/d2063e0e-ff32-49e8-acec-3f6b401f1793 HTTP/1.1" 200 744 62509 "-" "openstacksdk/3.0.0 keystoneauth1/5.6.0 python-requests/2.31.0 CPython/3.10.12"
77230-192.168.16.254 - - [26/Sep/2024:15:36:35 +0000] "GET /v2.0/lbaas/loadbalancers?project_id=04b3858f23984a109b2a5793263982bd HTTP/1.1" 200 782 76855 "-" "openstacksdk/3.0.0 keystoneauth1/5.6.0 python-requests/2.31.0 CPython/3.10.12"
77231:192.168.16.254 - - [26/Sep/2024:15:36:35 +0000] "GET /v2.0/lbaas/loadbalancers/d2063e0e-ff32-49e8-acec-3f6b401f1793 HTTP/1.1" 200 752 75174 "-" "openstacksdk/3.0.0 keystoneauth1/5.6.0 python-requests/2.31.0 CPython/3.10.12"
77232-192.168.16.254 - - [26/Sep/2024:15:36:40 +0000] "GET /v2.0/lbaas/loadbalancers?project_id=04b3858f23984a109b2a5793263982bd HTTP/1.1" 200 782 78412 "-" "openstacksdk/3.0.0 keystoneauth1/5.6.0 python-requests/2.31.0 CPython/3.10.12"
77233-192.168.16.254 - - [26/Sep/2024:15:36:40 +0000] "GET /v2.0/lbaas/loadbalancers HTTP/1.1" 200 782 72073 "-" "gophercloud/v1.5.0"
77234-192.168.16.254 - - [26/Sep/2024:15:36:40 +0000] "GET /v2.0/octavia/amphorae HTTP/1.1" 200 38 22995 "-" "gophercloud/v1.5.0"
77235-192.168.16.254 - - [26/Sep/2024:15:36:40 +0000] "GET /v2.0/lbaas/pools HTTP/1.1" 200 32 26296 "-" "gophercloud/v1.5.0"
77236-192.168.16.254 - - [26/Sep/2024:15:36:45 +0000] "GET /v2.0/lbaas/loadbalancers?project_id=04b3858f23984a109b2a5793263982bd HTTP/1.1" 200 782 89200 "-" "openstacksdk/3.0.0 keystoneauth1/5.6.0 python-requests/2.31.0 CPython/3.10.12"
root@manager:/home/dragon# grep -B5 -A5 -rn d2063e0e-ff32-49e8-acec-3f6b401f1793 /var/lib/docker/volumes/kolla_logs/_data/neutron/**neutron-server.log**

278637-2024-09-26 15:26:10.936 746 INFO neutron.wsgi [None req-b5fd121f-015a-4a0e-bf48-91839048951c 6e278a3ed4464f11858cd9c9139cf65a b5653b382e61428f8a5fea3d2400200a - - default default] 192.168.16.254,192.168.16.10 "GET /v2.0/extensions/dns-integration HTTP/1.1" status: 200  len: 347 time: 0.0029826
278638-2024-09-26 15:26:10.940 745 INFO neutron.wsgi [None req-ce32487f-e0ca-43c7-bbc9-de17ae782e7c 172947c0d35e4a75a9da6eccdf5a89f1 04b3858f23984a109b2a5793263982bd - - 1b06de491a7d4209afe7fa13952d056d 1b06de491a7d4209afe7fa13952d056d] 192.168.16.254,192.168.16.10 "GET /v2.0/floatingips?tenant_id=04b3858f23984a109b2a5793263982bd HTTP/1.1" status: 200  len: 1631 time: 0.0447590
278639-2024-09-26 15:26:10.942 746 INFO neutron.wsgi [None req-8409624d-a2ee-4f40-a4ea-76db6fe279cb 6e278a3ed4464f11858cd9c9139cf65a b5653b382e61428f8a5fea3d2400200a - - default default] 192.168.16.254,192.168.16.10 "GET /v2.0/extensions/qos HTTP/1.1" status: 200  len: 341 time: 0.0023730
278640-2024-09-26 15:26:10.948 745 INFO neutron.wsgi [None req-e0777ad0-7c46-42e2-91d5-b345ae0e10ec 6e278a3ed4464f11858cd9c9139cf65a b5653b382e61428f8a5fea3d2400200a - - default default] 192.168.16.254,192.168.16.10 "GET /v2.0/extensions/allowed-address-pairs HTTP/1.1" status: 200  len: 359 time: 0.0038643
278641-2024-09-26 15:26:10.959 746 INFO neutron.api.v2.resource [None req-ff54ed4b-0aa8-4fcb-9fdc-d7a1fc03085c 6e278a3ed4464f11858cd9c9139cf65a b5653b382e61428f8a5fea3d2400200a - - default default] show failed (client error): The resource could not be found.
278642:2024-09-26 15:26:10.960 746 INFO neutron.wsgi [None req-ff54ed4b-0aa8-4fcb-9fdc-d7a1fc03085c 6e278a3ed4464f11858cd9c9139cf65a b5653b382e61428f8a5fea3d2400200a - - default default] 192.168.16.254,192.168.16.10 "GET /v2.0/security-groups/lb-d2063e0e-ff32-49e8-acec-3f6b401f1793 HTTP/1.1" status: 404  len: 331 time: 0.0067644
278643:2024-09-26 15:26:10.981 745 INFO neutron.wsgi [None req-1bf04659-d7ec-46ab-8561-a41b12916cc9 6e278a3ed4464f11858cd9c9139cf65a b5653b382e61428f8a5fea3d2400200a - - default default] 192.168.16.254,192.168.16.10 "GET /v2.0/security-groups?name=lb-d2063e0e-ff32-49e8-acec-3f6b401f1793 HTTP/1.1" status: 200  len: 197 time: 0.0191512
278644-2024-09-26 15:26:11.132 745 INFO neutron.wsgi [None req-cceebafd-3851-4a09-a5b1-0a4789902248 172947c0d35e4a75a9da6eccdf5a89f1 04b3858f23984a109b2a5793263982bd - - 1b06de491a7d4209afe7fa13952d056d 1b06de491a7d4209afe7fa13952d056d] 192.168.16.254,192.168.16.10 "GET /v2.0/floatingips?tenant_id=04b3858f23984a109b2a5793263982bd HTTP/1.1" status: 200  len: 1631 time: 0.0540593
278645-2024-09-26 15:26:11.133 745 INFO neutron.db.ovn_revision_numbers_db [None req-0e5f8bad-22be-4479-b56f-1d19ecc90111 6e278a3ed4464f11858cd9c9139cf65a b5653b382e61428f8a5fea3d2400200a - - default default] Successfully bumped revision number for resource 822c4582-7616-43af-be6e-62cfa6fccdc5 (type: security_groups) to 1

References to existing reports

References to existing bug reports, mailing lists, ...

Severity

medium

Urgency

medium

@kayamax kayamax added the bug Something isn't working label Sep 26, 2024
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug Something isn't working
Projects
None yet
Development

No branches or pull requests

1 participant