← Back to team overview

yahoo-eng-team team mailing list archive

  1. yahoo-eng-team team
  2. Mailing list archive
  3. Message #91481

[Bug 2009956] [NEW] devstack: Nova serialproxy does not work

  Thread Previous • Date Previous • • Thread Next 
Public bug reported:

Steps to reproduce
==================
1. Install devstack with enable_service n-sproxy
2. Make sure /usr/local/bin/nova-serialproxy is running after devstack is installed.
3. Create server from cirros image
4. nova get-serial-console <server_name>
5. Try to connect via client defined at https://docs.openstack.org/nova/latest/contributor/testing/serial-console.html
6. It just hangs


Nova-serialproxy logs
=====================

Mär 10 14:06:10 ubnt-20 nova-serialproxy[435616]: DEBUG nova.console.websocketproxy [-] 192.168.2.104: new handler Process {{(pid=435616) vmsg /usr/local/lib/python3.8/dist-packages/websockify/websockifyserver.py:605}}
Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: INFO nova.console.websocketproxy [-] 192.168.2.104 - - [10/Mar/2023 14:06:10] 192.168.2.104: Plain non-SSL (ws://) WebSocket connection
Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: INFO nova.console.websocketproxy [-] 192.168.2.104 - - [10/Mar/2023 14:06:10] 192.168.2.104: Path: '/?token=d0ff9969-9b30-416c-9c45-f97863175eff'
Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: INFO dbcounter [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None] Registered counter for database nova_cell1
Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: DEBUG oslo_db.sqlalchemy.engines [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None] MySQL server mode set to STRICT_TRANS_TABLES,STRICT_ALL_TABLES,NO_ZERO_IN_DATE,NO_ZERO_DATE,ERROR_FOR_DIVISION_BY_ZERO,TRADITIONAL,NO_ENGINE_SUBSTITUTION {{(pid=470418) _check_effective_sql_mode /usr/local/lib/python3.8/dist-packages/oslo_db/sqlalchemy/engines.py:335}}
Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: DEBUG dbcounter [-] [470418] Writer thread running {{(pid=470418) stat_writer /usr/local/lib/python3.8/dist-packages/dbcounter.py:99}}
Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: DEBUG nova.objects.console_auth_token [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None] Validated token - console connection is ConsoleAuthToken(access_url_base='ws://192.168.2.104:6082/',console_type='serial',created_at=2023-03-10T13:00:38Z,host='127.0.0.1',id=11,instance_uuid=b94e6725-88b2-4fd9-be62-d25a15ab4a8a,internal_access_path=None,port=10001,token='***',updated_at=None) {{(pid=470418) validate /opt/stack/nova/nova/objects/console_auth_token.py:153}}
Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: DEBUG oslo_concurrency.lockutils [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None] Acquiring lock "compute-rpcapi-router" {{(pid=470418) lock /usr/local/lib/python3.8/dist-packages/oslo_concurrency/lockutils.py:312}}
Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: DEBUG oslo_concurrency.lockutils [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None] Acquired lock "compute-rpcapi-router" {{(pid=470418) lock /usr/local/lib/python3.8/dist-packages/oslo_concurrency/lockutils.py:315}}
Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: DEBUG oslo_concurrency.lockutils [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None] Releasing lock "compute-rpcapi-router" {{(pid=470418) lock /usr/local/lib/python3.8/dist-packages/oslo_concurrency/lockutils.py:333}}
Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: INFO nova.console.websocketproxy [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None]  35: connect info: ConsoleAuthToken(access_url_base='ws://192.168.2.104:6082/',console_type='serial',created_at=2023-03-10T13:00:38Z,host='127.0.0.1',id=11,instance_uuid=b94e6725-88b2-4fd9-be62-d25a15ab4a8a,internal_access_path=None,port=10001,token='***',updated_at=None)
Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: INFO nova.console.websocketproxy [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None]  35: connecting to: 127.0.0.1:10001


Also tried https://blog.oddbit.com/post/2014-12-22-accessing-the-serial-
console-o/ and https://github.com/larsks/novaconsole, but faced similar
issue

** Affects: nova
     Importance: Undecided
         Status: New

-- 
You received this bug notification because you are a member of Yahoo!
Engineering Team, which is subscribed to OpenStack Compute (nova).
https://bugs.launchpad.net/bugs/2009956

Title:
  devstack:  Nova serialproxy does not work

Status in OpenStack Compute (nova):
  New

Bug description:
  Steps to reproduce
  ==================
  1. Install devstack with enable_service n-sproxy
  2. Make sure /usr/local/bin/nova-serialproxy is running after devstack is installed.
  3. Create server from cirros image
  4. nova get-serial-console <server_name>
  5. Try to connect via client defined at https://docs.openstack.org/nova/latest/contributor/testing/serial-console.html
  6. It just hangs

  
  Nova-serialproxy logs
  =====================

  Mär 10 14:06:10 ubnt-20 nova-serialproxy[435616]: DEBUG nova.console.websocketproxy [-] 192.168.2.104: new handler Process {{(pid=435616) vmsg /usr/local/lib/python3.8/dist-packages/websockify/websockifyserver.py:605}}
  Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: INFO nova.console.websocketproxy [-] 192.168.2.104 - - [10/Mar/2023 14:06:10] 192.168.2.104: Plain non-SSL (ws://) WebSocket connection
  Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: INFO nova.console.websocketproxy [-] 192.168.2.104 - - [10/Mar/2023 14:06:10] 192.168.2.104: Path: '/?token=d0ff9969-9b30-416c-9c45-f97863175eff'
  Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: INFO dbcounter [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None] Registered counter for database nova_cell1
  Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: DEBUG oslo_db.sqlalchemy.engines [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None] MySQL server mode set to STRICT_TRANS_TABLES,STRICT_ALL_TABLES,NO_ZERO_IN_DATE,NO_ZERO_DATE,ERROR_FOR_DIVISION_BY_ZERO,TRADITIONAL,NO_ENGINE_SUBSTITUTION {{(pid=470418) _check_effective_sql_mode /usr/local/lib/python3.8/dist-packages/oslo_db/sqlalchemy/engines.py:335}}
  Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: DEBUG dbcounter [-] [470418] Writer thread running {{(pid=470418) stat_writer /usr/local/lib/python3.8/dist-packages/dbcounter.py:99}}
  Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: DEBUG nova.objects.console_auth_token [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None] Validated token - console connection is ConsoleAuthToken(access_url_base='ws://192.168.2.104:6082/',console_type='serial',created_at=2023-03-10T13:00:38Z,host='127.0.0.1',id=11,instance_uuid=b94e6725-88b2-4fd9-be62-d25a15ab4a8a,internal_access_path=None,port=10001,token='***',updated_at=None) {{(pid=470418) validate /opt/stack/nova/nova/objects/console_auth_token.py:153}}
  Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: DEBUG oslo_concurrency.lockutils [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None] Acquiring lock "compute-rpcapi-router" {{(pid=470418) lock /usr/local/lib/python3.8/dist-packages/oslo_concurrency/lockutils.py:312}}
  Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: DEBUG oslo_concurrency.lockutils [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None] Acquired lock "compute-rpcapi-router" {{(pid=470418) lock /usr/local/lib/python3.8/dist-packages/oslo_concurrency/lockutils.py:315}}
  Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: DEBUG oslo_concurrency.lockutils [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None] Releasing lock "compute-rpcapi-router" {{(pid=470418) lock /usr/local/lib/python3.8/dist-packages/oslo_concurrency/lockutils.py:333}}
  Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: INFO nova.console.websocketproxy [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None]  35: connect info: ConsoleAuthToken(access_url_base='ws://192.168.2.104:6082/',console_type='serial',created_at=2023-03-10T13:00:38Z,host='127.0.0.1',id=11,instance_uuid=b94e6725-88b2-4fd9-be62-d25a15ab4a8a,internal_access_path=None,port=10001,token='***',updated_at=None)
  Mär 10 14:06:10 ubnt-20 nova-serialproxy[470418]: INFO nova.console.websocketproxy [None req-48db546e-0d8e-4f0e-9e52-07e1bab54a51 None None]  35: connecting to: 127.0.0.1:10001


  
  Also tried https://blog.oddbit.com/post/2014-12-22-accessing-the-serial-console-o/ and https://github.com/larsks/novaconsole, but faced similar issue

To manage notifications about this bug go to:
https://bugs.launchpad.net/nova/+bug/2009956/+subscriptions

Follow ups

  Thread Previous • Date Previous • • Thread Next