QA » openQA Project

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