Test run: - Start at Wed Sep 23 21:04:41 UTC 2026 - Docker image: "monitor-test-runner:scli-manual-manual" - Container name: "test-run-554898fc-a362-4384-ae5a-3d273212e561" - Runner git commit: b81e403a61c53e380fb69905a7df6b5141039e8a 2026-08-11T11:59:29+02:00 Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Uninstalled 1 package in 0.85ms Installed 1 package in 1ms Run Test: slices-bi-singlenode-login 2026-09-23 21:04:44.373597 UTC - OS release: PRETTY_NAME="Debian GNU/Linux 13 (trixie)" NAME="Debian GNU/Linux" VERSION_ID="13" VERSION="13 (trixie)" VERSION_CODENAME=trixie DEBIAN_VERSION_FULL=13.5 ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" 2026-09-23 21:04:44.377273 UTC - ls -a /root/ /scripts/: '/root/:\n.\n..\n.bashrc\n.cache\n.local\n.profile\n.slices\n.wget-hsts\n\n/scripts/:\n.\n..\n.slices\nrun_test_runner.sh\n' 2026-09-23 21:04:44.377346 UTC - env: {'PATH': '/app/.venv/bin:/usr/local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/root/.local/bin/', 'COLUMNS': '200'} 2026-09-23 21:04:44.377471 UTC - which slices: /usr/local/bin/slices 2026-09-23 21:04:44.377494 UTC - Slices CLI exe: 'slices' 2026-09-23 21:04:44.377700 UTC - Run: slices --version 2026-09-23 21:04:47.598763 UTC - version: Slices CLI v2026.1.3 Slices CLI core v1.2.6 Slices CLI ai v1.1.0 Slices CLI bi v2.2.1 Slices clientlib bi v6.1.1 Slices clientlib core v5.6.0 Slices clientlib ai v1.0.0 2026-09-23 21:04:47.599546 UTC - Run: slices pubkey list --format text 2026-09-23 21:04:48.367269 UTC - Pubkey already registered 2026-09-23 21:04:48.367573 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-09-23 21:04:49.032847 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-09-23 21:04:49.032941 UTC - Check List Flavors 2026-09-23 21:04:49.033087 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-09-23 21:04:49.748491 UTC - Check List DiskImages 2026-09-23 21:04:49.748702 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-09-23 21:04:50.464241 UTC - Requesting resources 2026-09-23 21:04:50.464799 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-f0ad2459 2026-09-23 21:04:51.736832 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01m381bst7ed9bcysfyhgs5v2z 2026-09-23 21:04:51.737050 UTC - Waiting until resource ready 2026-09-23 21:04:53.737496 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-f0ad2459 tst 2026-09-23 21:04:54.553236 UTC - Status: IMAGING 2026-09-23 21:04:57.319709 UTC - Status: IMAGING 2026-09-23 21:05:00.136011 UTC - Status: IMAGING 2026-09-23 21:05:03.002563 UTC - Status: STARTING 2026-09-23 21:05:06.019901 UTC - Status: STARTING 2026-09-23 21:05:08.989732 UTC - Status: STARTING 2026-09-23 21:05:11.805857 UTC - Status: STARTING 2026-09-23 21:05:14.572885 UTC - Status: STARTING 2026-09-23 21:05:17.339556 UTC - Status: STARTING 2026-09-23 21:05:20.156741 UTC - Status: STARTING 2026-09-23 21:05:22.928749 UTC - Status: STARTING 2026-09-23 21:05:25.695455 UTC - Status: STARTING 2026-09-23 21:05:28.512277 UTC - Status: STARTING 2026-09-23 21:05:31.278745 UTC - Status: STARTING 2026-09-23 21:05:34.095609 UTC - Status: STARTING 2026-09-23 21:05:36.962587 UTC - Status: STARTING 2026-09-23 21:05:39.779497 UTC - Status: STARTING 2026-09-23 21:05:42.546476 UTC - Status: STARTING 2026-09-23 21:05:45.362891 UTC - Status: STARTING 2026-09-23 21:05:48.179491 UTC - Status: STARTING 2026-09-23 21:05:51.047029 UTC - Status: STARTING 2026-09-23 21:05:53.913532 UTC - Status: STARTING 2026-09-23 21:05:56.780643 UTC - Status: STARTING 2026-09-23 21:05:59.648054 UTC - Status: STARTING 2026-09-23 21:06:02.464876 UTC - Status: STARTING 2026-09-23 21:06:05.332240 UTC - Status: STARTING 2026-09-23 21:06:08.198717 UTC - Status: STARTING 2026-09-23 21:06:11.014732 UTC - Status: STARTING 2026-09-23 21:06:13.881573 UTC - Status: STARTING 2026-09-23 21:06:16.697637 UTC - Status: STARTING 2026-09-23 21:06:19.464271 UTC - Status: STARTING 2026-09-23 21:06:22.280612 UTC - Status: STARTING 2026-09-23 21:06:25.247492 UTC - Status: STARTING 2026-09-23 21:06:28.064667 UTC - Status: STARTING 2026-09-23 21:06:30.880789 UTC - Status: STARTING 2026-09-23 21:06:33.747876 UTC - Status: STARTING 2026-09-23 21:06:36.564046 UTC - Status: STARTING 2026-09-23 21:06:39.381241 UTC - Status: STARTING 2026-09-23 21:06:42.247684 UTC - Status: STARTING 2026-09-23 21:06:45.064121 UTC - Status: STARTING 2026-09-23 21:06:47.880178 UTC - Status: STARTING 2026-09-23 21:06:50.646515 UTC - Status: STARTING 2026-09-23 21:06:53.613101 UTC - Status: STARTING 2026-09-23 21:06:56.429530 UTC - Status: STARTING 2026-09-23 21:06:59.245644 UTC - Status: STARTING 2026-09-23 21:07:02.162978 UTC - Status: STARTING 2026-09-23 21:07:04.979027 UTC - Status: STARTING 2026-09-23 21:07:07.745573 UTC - Status: STARTING 2026-09-23 21:07:10.563209 UTC - Status: STARTING 2026-09-23 21:07:13.480928 UTC - Status: STARTING 2026-09-23 21:07:16.297751 UTC - Status: STARTING 2026-09-23 21:07:19.115047 UTC - Status: STARTING 2026-09-23 21:07:21.932244 UTC - Status: STARTING 2026-09-23 21:07:24.749570 UTC - Status: STARTING 2026-09-23 21:07:27.566147 UTC - Status: STARTING 2026-09-23 21:07:30.332839 UTC - Status: STARTING 2026-09-23 21:07:33.099744 UTC - Status: STARTING 2026-09-23 21:07:35.866166 UTC - Status: STARTING 2026-09-23 21:07:38.632521 UTC - Status: STARTING 2026-09-23 21:07:41.449459 UTC - Status: STARTING 2026-09-23 21:07:44.266110 UTC - Status: STARTING 2026-09-23 21:07:47.082983 UTC - Status: STARTING 2026-09-23 21:07:49.849322 UTC - Status: STARTING 2026-09-23 21:07:52.615849 UTC - Status: STARTING 2026-09-23 21:07:55.433053 UTC - Status: STARTING 2026-09-23 21:07:58.249867 UTC - Status: STARTING 2026-09-23 21:08:01.016430 UTC - Status: STARTING 2026-09-23 21:08:03.833237 UTC - Status: STARTING 2026-09-23 21:08:06.649842 UTC - Status: STARTING 2026-09-23 21:08:09.416186 UTC - Status: STARTING 2026-09-23 21:08:12.233298 UTC - Status: STARTING 2026-09-23 21:08:14.999564 UTC - Status: UP 2026-09-23 21:08:14.999644 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01m381bsh4ev18c8zvzf9081w0 2026-09-23 21:08:14.999684 UTC - Validate resources 2026-09-23 21:08:15.816178 UTC - The fields of the created resource were validated. 2026-09-23 21:08:15.816272 UTC - Check if resources are registered in experiment 2026-09-23 21:08:15.816454 UTC - Run: slices experiment list-resources --format json tst-f0ad2459 2026-09-23 21:08:16.684413 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resources_command_1.txt': slices experiment list-resources --format json tst-f0ad2459 2026-09-23 21:08:16.684502 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-23 21:08:16.684531 UTC - Error in test step 'Check experiment print-resources': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-23 21:08:16.684592 UTC - Wait 5s before retry 2026-09-23 21:08:22.351432 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry1_retry1_command_1.txt': slices experiment list-resources --format json tst-f0ad2459 2026-09-23 21:08:22.351545 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-23 21:08:22.351573 UTC - Error in test step 'Check experiment print-resources (Retry 1)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-23 21:08:22.351647 UTC - Wait 5s before retry 2026-09-23 21:08:28.018589 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry2_retry2_command_1.txt': slices experiment list-resources --format json tst-f0ad2459 2026-09-23 21:08:28.018679 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-23 21:08:28.018713 UTC - Error in test step 'Check experiment print-resources (Retry 2)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-23 21:08:28.018775 UTC - Wait 5s before retry 2026-09-23 21:08:33.685679 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry3_retry3_command_1.txt': slices experiment list-resources --format json tst-f0ad2459 2026-09-23 21:08:33.685767 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-23 21:08:33.685790 UTC - Error in test step 'Check experiment print-resources (Retry 3)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-23 21:08:33.685845 UTC - Wait 5s before retry 2026-09-23 21:08:39.352818 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry4_retry4_command_1.txt': slices experiment list-resources --format json tst-f0ad2459 2026-09-23 21:08:39.352910 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-23 21:08:39.352949 UTC - Error in test step 'Check experiment print-resources (Retry 4)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-23 21:08:39.353005 UTC - Wait 5s before retry 2026-09-23 21:08:45.070027 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry5_retry5_command_1.txt': slices experiment list-resources --format json tst-f0ad2459 2026-09-23 21:08:45.070129 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-23 21:08:45.070152 UTC - Error in test step 'Check experiment print-resources (Retry 5)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-23 21:08:45.070216 UTC - Wait 5s before retry 2026-09-23 21:08:50.787508 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry6_retry6_command_1.txt': slices experiment list-resources --format json tst-f0ad2459 2026-09-23 21:08:50.787596 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-23 21:08:50.787620 UTC - Error in test step 'Check experiment print-resources (Retry 6)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-23 21:08:50.787671 UTC - Wait 5s before retry 2026-09-23 21:08:56.505304 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry7_retry7_command_1.txt': slices experiment list-resources --format json tst-f0ad2459 2026-09-23 21:08:56.505462 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-23 21:08:56.505505 UTC - Error in test step 'Check experiment print-resources (Retry 7)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-23 21:08:56.505568 UTC - Wait 5s before retry 2026-09-23 21:09:02.223313 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry8_retry8_command_1.txt': slices experiment list-resources --format json tst-f0ad2459 2026-09-23 21:09:02.223424 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-23 21:09:02.223450 UTC - Error in test step 'Check experiment print-resources (Retry 8)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-23 21:09:02.223505 UTC - Wait 5s before retry 2026-09-23 21:09:07.941150 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry9_retry9_command_1.txt': slices experiment list-resources --format json tst-f0ad2459 2026-09-23 21:09:07.941250 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-23 21:09:07.941274 UTC - Error in test step 'Check experiment print-resources (Retry 9)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-23 21:09:07.941344 UTC - Wait 5s before retry 2026-09-23 21:09:13.608780 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry10_retry10_command_1.txt': slices experiment list-resources --format json tst-f0ad2459 2026-09-23 21:09:13.608868 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-23 21:09:13.608891 UTC - Error in test step 'Check experiment print-resources (Retry 10)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-23 21:09:13.608986 UTC - Testing extend expires_at (all resources in experiment) 2026-09-23 21:09:13.609093 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-f0ad2459 2026-09-23 21:09:14.425958 UTC - Content of log file '/test_dir/step_Checkextendexpire_command_1.txt': slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-f0ad2459 2026-09-23 21:09:14.426061 UTC - Content of log file '/test_dir/experiment-extend-all.txt': There are no active resources to extend ❌ 2026-09-23 21:09:14.426087 UTC - Error in test step 'Check extend expire': "slices bi extend" failed 2026-09-23 21:09:14.426152 UTC - Testing ssh login 2026-09-23 21:09:14.440703 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-f0ad2459 tst 2026-09-23 21:09:15.257501 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-f0ad2459 tst 2026-09-23 21:09:16.124274 UTC - Content of log file '/test_dir/step_CheckSSHpubkeyresource_command_1.txt': slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-f0ad2459 tst 2026-09-23 21:09:16.124373 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-09-23 21:09:16.124411 UTC - Error in test step 'Check SSH pubkey (resource)': "slices bi ssh --show server_pubkey_openssh" did not return output on stdout 2026-09-23 21:09:16.134973 UTC - Destroying tst-f0ad2459 tst ERROR:slices_monitor_test_runner.main:Test Failed with exception Traceback (most recent call last): File "/app/src/slices_monitor_test_runner/main.py", line 86, in run_test return test_runner.run() ~~~~~~~~~~~~~~~^^ File "/app/src/slices_monitor_test_runner/test_runners/slices_singlenode_login.py", line 1702, in run self._ssh_login(test_privkey_pem, ssh_agent_env_vars) ~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/app/src/slices_monitor_test_runner/test_runners/slices_singlenode_login.py", line 1275, in _ssh_login server_openssh_pubkeys = self._ssh_login_pubkey(proxy_key=False) File "/app/src/slices_monitor_test_runner/test_runners/slices_singlenode_login.py", line 1203, in _ssh_login_pubkey return server_openssh_pubkeys ^^^^^^^^^^^^^^^^^^^^^^ UnboundLocalError: cannot access local variable 'server_openssh_pubkeys' where it is not associated with a value 2026-09-23 21:09:16.135229 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-f0ad2459 tst