QA (public) » openQA Project (public)

Observation¶

Frequently establishing websocket connection will cause it hard to match the next needle, as the sending key action was lost. Refer to the following job links.

https://openqa.suse.de/tests/10443972/logfile?filename=autoinst-log.txt
(After sending key 'ret', the websocket connection was closed which cause the key was actually not received by installer.)

[2023-02-07T16:06:34.061841+01:00] [debug] [pid:11593] tests/migration/online_migration/online_migration_setup.pm:26 called opensusebasetest::wait_boot -> lib/opensusebasetest.pm:919 called opensusebasetest::wait_boot_past_bootloader -> lib/opensusebasetest.pm:798 called opensusebasetest::handle_displaymanager_login -> lib/opensusebasetest.pm:600 called x11utils::handle_login -> lib/x11utils.pm:287 called x11utils::select_user_gnome -> lib/x11utils.pm:361 called testapi::send_key
[2023-02-07T16:06:34.062001+01:00] [debug] [pid:11593] <<< testapi::send_key(key="ret", do_wait=0, wait_screen_change=0)
[2023-02-07T16:06:34.130287+01:00] [debug] [pid:11594] considering VNC stalled, no update for 5.42 seconds
[2023-02-07 16:06:34.13047] [18272] [info] Client closed connection

https://openqa.suse.de/tests/10448675/logfile?filename=autoinst-log.txt
(After sending key 'alt-n', the websocket connection was closed.)

[2023-02-08T04:14:50.502113+01:00] [debug] [pid:12018] tests/installation/scc_registration.pm:25 called registration::fill_in_registration_data -> lib/registration.pm:605 called registration::process_modules -> lib/registration.pm:1010 called registration::process_scc_register_addons -> lib/registration.pm:504 called testapi::wait_screen_change -> lib/registration.pm:504 called testapi::send_key
[2023-02-08T04:14:50.502296+01:00] [debug] [pid:12018] <<< testapi::send_key(key="alt-n", do_wait=0, wait_screen_change=0)
[2023-02-08T04:14:50.684616+01:00] [debug] [pid:12019] considering VNC stalled, no update for 1675826090.68 seconds
[2023-02-08 04:14:50.68489] [14326] [info] Client closed connection

http://10.67.129.96/tests/1848/logfile?filename=autoinst-log.txt
(Before sending key 'alt-y', the websocket connection was closed.)

[2023-02-08T17:35:48.410521+08:00] [warn] [pid:9161] !!! backend::baseclass::check_asserted_screen: check_asserted_screen took 4.30 seconds for 137 candidate needles - make your needles more specific
[2023-02-08T17:35:48.410756+08:00] [debug] [pid:9161] no match: 359.9s, best candidate: registration-refreshing-repository-text-20210317 (0.29)
[2023-02-08 17:36:03.42835] [9750] [info] Client closed connection
[2023-02-08 17:36:03.43039] [9750] [info] WebSocket closed with status 1000.
[2023-02-08T17:36:08.476712+08:00] [debug] [pid:9160] >>> testapi::_handle_found_needle: found registration-online-repos-15sp1-20181217, similarity 1.00 @ 258/336
[2023-02-08T17:36:08.478434+08:00] [debug] [pid:9160] tests/installation/scc_registration.pm:25 called registration::fill_in_registration_data -> lib/registration.pm:596 called registration::handle_scc_popups -> lib/registration.pm:663 called testapi::wait_screen_change
[2023-02-08T17:36:08.478679+08:00] [debug] [pid:9160] <<< testapi::wait_screen_change(timeout=10, similarity_level=50)
[2023-02-08T17:36:08.480838+08:00] [debug] [pid:9160] tests/installation/scc_registration.pm:25 called registration::fill_in_registration_data -> lib/registration.pm:596 called registration::handle_scc_popups -> lib/registration.pm:663 called testapi::wait_screen_change -> lib/registration.pm:663 called testapi::send_key
[2023-02-08T17:36:08.481091+08:00] [debug] [pid:9160] <<< testapi::send_key(key="alt-y", do_wait=0, wait_screen_change=0)
[2023-02-08T17:36:08.629838+08:00] [debug] [pid:9161] considering VNC stalled, no update for 20.22 seconds
[2023-02-08T17:36:08.631376+08:00] [debug] [pid:9161] Establishing VNC connection over WebSockets via https://10.67.131.2
[2023-02-08 17:36:09.69433] [9809] [info] Establishing WebSocket connection to wss://vh002.qa2.suse.asia:443/ticket/227709543f641d16
[2023-02-08 17:36:09.69545] [9809] [info] Client accepted
[2023-02-08 17:36:09.70746] [9809] [info] WebSocket connection established

Steps to reproduce¶

Trigger below test runs in OSD:
https://openqa.suse.de/tests/overview?distri=sle&version=15-SP5&build=72.4&groupid=264
default_install_svirt
online_upgrade_sles15sp4_vmware
textmode_svirt

Impact¶

Vmware7.0 tests with svirt backend can't be passed.

Problem¶

In my local openqa env, some of job run passed. Not sure any difference in OSD env.
default_install_svirt - http://10.67.129.96/tests/1875
online_upgrade_sles15sp4_vmware - http://10.67.129.96/tests/1873

Suggestion¶

Increase the interval for establishing connections

Workaround¶

No