Test run: - Start at Tue Sep 29 21:04:41 UTC 2026 - Docker image: "monitor-test-runner:scli-manual-manual" - Container name: "test-run-b7eedf01-3545-4ffc-b54f-007fc12b9283" - Runner git commit: 3d31de04c823a30705ff3eab5a5f3c3f420ec99c 2026-09-25T10:35:24+02:00 Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Uninstalled 1 package in 0.76ms Installed 1 package in 1ms Run Test: slices-bi-singlenode-login 2026-09-29 21:04:45.500794 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-29 21:04:45.503207 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-29 21:04:45.503314 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-29 21:04:45.503475 UTC - which slices: /usr/local/bin/slices 2026-09-29 21:04:45.503504 UTC - Slices CLI exe: 'slices' 2026-09-29 21:04:45.503903 UTC - Run: slices --version 2026-09-29 21:04:49.088910 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-29 21:04:49.089680 UTC - Run: slices pubkey list --format text 2026-09-29 21:04:50.209003 UTC - Pubkey already registered 2026-09-29 21:04:50.209257 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-09-29 21:04:51.095650 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-09-29 21:04:51.095742 UTC - Check List Flavors 2026-09-29 21:04:51.095875 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-09-29 21:04:52.377265 UTC - Check List DiskImages 2026-09-29 21:04:52.377511 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-09-29 21:04:53.496482 UTC - Requesting resources 2026-09-29 21:04:53.497467 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-559cb857 2026-09-29 21:04:54.775252 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01m3qfr6sgebgva7a1wk2g18q9 2026-09-29 21:04:54.775424 UTC - Waiting until resource ready 2026-09-29 21:04:56.775777 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-559cb857 tst 2026-09-29 21:04:57.698391 UTC - Status: IMAGING 2026-09-29 21:05:00.514611 UTC - Status: DELETED 2026-09-29 21:05:03.334696 UTC - Status: STARTING 2026-09-29 21:05:06.151239 UTC - Status: STARTING 2026-09-29 21:05:09.168143 UTC - Status: STARTING 2026-09-29 21:05:11.984323 UTC - Status: STARTING 2026-09-29 21:05:14.802433 UTC - Status: STARTING 2026-09-29 21:05:17.769285 UTC - Status: STARTING 2026-09-29 21:05:20.586279 UTC - Status: STARTING 2026-09-29 21:05:23.603654 UTC - Status: STARTING 2026-09-29 21:05:26.420316 UTC - Status: STARTING 2026-09-29 21:05:29.237231 UTC - Status: STARTING 2026-09-29 21:05:32.003529 UTC - Status: STARTING 2026-09-29 21:05:34.870558 UTC - Status: STARTING 2026-09-29 21:05:37.687340 UTC - Status: STARTING 2026-09-29 21:05:40.554148 UTC - Status: STARTING 2026-09-29 21:05:43.370848 UTC - Status: STARTING 2026-09-29 21:05:46.137485 UTC - Status: STARTING 2026-09-29 21:05:49.005245 UTC - Status: STARTING 2026-09-29 21:05:51.871890 UTC - Status: STARTING 2026-09-29 21:05:54.687941 UTC - Status: STARTING 2026-09-29 21:05:57.554991 UTC - Status: STARTING 2026-09-29 21:06:00.371096 UTC - Status: STARTING 2026-09-29 21:06:03.237453 UTC - Status: STARTING 2026-09-29 21:06:06.104951 UTC - Status: STARTING 2026-09-29 21:06:08.921417 UTC - Status: STARTING 2026-09-29 21:06:11.788323 UTC - Status: STARTING 2026-09-29 21:06:14.654830 UTC - Status: STARTING 2026-09-29 21:06:17.521464 UTC - Status: STARTING 2026-09-29 21:06:20.388042 UTC - Status: STARTING 2026-09-29 21:06:23.216123 UTC - Status: STARTING 2026-09-29 21:06:26.032979 UTC - Status: STARTING 2026-09-29 21:06:28.851580 UTC - Status: STARTING 2026-09-29 21:06:31.667823 UTC - Status: STARTING 2026-09-29 21:06:34.484323 UTC - Status: STARTING 2026-09-29 21:06:37.300802 UTC - Status: STARTING 2026-09-29 21:06:40.117630 UTC - Status: STARTING 2026-09-29 21:06:42.984048 UTC - Status: STARTING 2026-09-29 21:06:45.800609 UTC - Status: STARTING 2026-09-29 21:06:48.616680 UTC - Status: STARTING 2026-09-29 21:06:51.484032 UTC - Status: STARTING 2026-09-29 21:06:54.300081 UTC - Status: STARTING 2026-09-29 21:06:57.116712 UTC - Status: STARTING 2026-09-29 21:06:59.932870 UTC - Status: STARTING 2026-09-29 21:07:02.749126 UTC - Status: STARTING 2026-09-29 21:07:05.615515 UTC - Status: STARTING 2026-09-29 21:07:08.432379 UTC - Status: STARTING 2026-09-29 21:07:11.198609 UTC - Status: STARTING 2026-09-29 21:07:14.116346 UTC - Status: STARTING 2026-09-29 21:07:16.933092 UTC - Status: STARTING 2026-09-29 21:07:19.799664 UTC - Status: STARTING 2026-09-29 21:07:22.566442 UTC - Status: STARTING 2026-09-29 21:07:25.433635 UTC - Status: STARTING 2026-09-29 21:07:28.250044 UTC - Status: STARTING 2026-09-29 21:07:31.066583 UTC - Status: STARTING 2026-09-29 21:07:33.883392 UTC - Status: STARTING 2026-09-29 21:07:36.801150 UTC - Status: STARTING 2026-09-29 21:07:39.617812 UTC - Status: STARTING 2026-09-29 21:07:42.434627 UTC - Status: STARTING 2026-09-29 21:07:45.251499 UTC - Status: STARTING 2026-09-29 21:07:48.118541 UTC - Status: STARTING 2026-09-29 21:07:50.935251 UTC - Status: STARTING 2026-09-29 21:07:53.701548 UTC - Status: STARTING 2026-09-29 21:07:56.518473 UTC - Status: UP 2026-09-29 21:07:56.518590 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01m3qfr6g9fy5sz72rk7yhaqmm 2026-09-29 21:07:56.518662 UTC - Validate resources 2026-09-29 21:07:57.386564 UTC - The fields of the created resource were validated. 2026-09-29 21:07:57.386734 UTC - Check if resources are registered in experiment 2026-09-29 21:07:57.387001 UTC - Run: slices experiment list-resources --format json tst-559cb857 2026-09-29 21:07:58.104524 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resources_command_1.txt': slices experiment list-resources --format json tst-559cb857 2026-09-29 21:07:58.104644 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-29 21:07:58.104684 UTC - Error in test step 'Check experiment print-resources': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-29 21:07:58.104808 UTC - Wait 5s before retry 2026-09-29 21:08:03.872567 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry1_retry1_command_1.txt': slices experiment list-resources --format json tst-559cb857 2026-09-29 21:08:03.872663 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-29 21:08:03.872688 UTC - Error in test step 'Check experiment print-resources (Retry 1)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-29 21:08:03.872791 UTC - Wait 5s before retry 2026-09-29 21:08:09.590632 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry2_retry2_command_1.txt': slices experiment list-resources --format json tst-559cb857 2026-09-29 21:08:09.590759 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-29 21:08:09.590787 UTC - Error in test step 'Check experiment print-resources (Retry 2)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-29 21:08:09.590867 UTC - Wait 5s before retry 2026-09-29 21:08:15.409558 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry3_retry3_command_1.txt': slices experiment list-resources --format json tst-559cb857 2026-09-29 21:08:15.409673 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-29 21:08:15.409698 UTC - Error in test step 'Check experiment print-resources (Retry 3)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-29 21:08:15.409767 UTC - Wait 5s before retry 2026-09-29 21:08:21.177710 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry4_retry4_command_1.txt': slices experiment list-resources --format json tst-559cb857 2026-09-29 21:08:21.177813 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-29 21:08:21.177837 UTC - Error in test step 'Check experiment print-resources (Retry 4)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-29 21:08:21.177902 UTC - Wait 5s before retry 2026-09-29 21:08:26.995982 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry5_retry5_command_1.txt': slices experiment list-resources --format json tst-559cb857 2026-09-29 21:08:26.996090 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-29 21:08:26.996120 UTC - Error in test step 'Check experiment print-resources (Retry 5)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-29 21:08:26.996174 UTC - Wait 5s before retry 2026-09-29 21:08:32.663697 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry6_retry6_command_1.txt': slices experiment list-resources --format json tst-559cb857 2026-09-29 21:08:32.663797 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-29 21:08:32.663821 UTC - Error in test step 'Check experiment print-resources (Retry 6)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-29 21:08:32.663887 UTC - Wait 5s before retry 2026-09-29 21:08:38.381570 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry7_retry7_command_1.txt': slices experiment list-resources --format json tst-559cb857 2026-09-29 21:08:38.381656 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-29 21:08:38.381678 UTC - Error in test step 'Check experiment print-resources (Retry 7)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-29 21:08:38.381734 UTC - Wait 5s before retry 2026-09-29 21:08:44.048681 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry8_retry8_command_1.txt': slices experiment list-resources --format json tst-559cb857 2026-09-29 21:08:44.048792 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-29 21:08:44.048822 UTC - Error in test step 'Check experiment print-resources (Retry 8)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-29 21:08:44.048885 UTC - Wait 5s before retry 2026-09-29 21:08:49.816318 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry9_retry9_command_1.txt': slices experiment list-resources --format json tst-559cb857 2026-09-29 21:08:49.816447 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-29 21:08:49.816489 UTC - Error in test step 'Check experiment print-resources (Retry 9)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-29 21:08:49.816563 UTC - Wait 5s before retry 2026-09-29 21:08:55.483476 UTC - Content of log file '/test_dir/step_Checkexperimentprint-resourcesRetry10_retry10_command_1.txt': slices experiment list-resources --format json tst-559cb857 2026-09-29 21:08:55.483564 UTC - Content of log file '/test_dir/experiment-list-resources.txt': [] 2026-09-29 21:08:55.483588 UTC - Error in test step 'Check experiment print-resources (Retry 10)': "slices experiment list-resources" returned 0 resources instead of 1 2026-09-29 21:08:55.483693 UTC - Testing extend expires_at (all resources in experiment) 2026-09-29 21:08:55.483803 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-559cb857 2026-09-29 21:08:56.300948 UTC - Content of log file '/test_dir/step_Checkextendexpire_command_1.txt': slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-559cb857 2026-09-29 21:08:56.301108 UTC - Content of log file '/test_dir/experiment-extend-all.txt': There are no active resources to extend ❌ 2026-09-29 21:08:56.301156 UTC - Error in test step 'Check extend expire': "slices bi extend" failed 2026-09-29 21:08:56.301252 UTC - Testing ssh login 2026-09-29 21:08:56.317283 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-559cb857 tst 2026-09-29 21:08:57.133872 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-559cb857 tst 2026-09-29 21:08:57.950680 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-559cb857 tst 2026-09-29 21:08:57.950806 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-09-29 21:08:57.950834 UTC - Error in test step 'Check SSH pubkey (resource)': "slices bi ssh --show server_pubkey_openssh" did not return output on stdout 2026-09-29 21:08:57.957944 UTC - Destroying tst-559cb857 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-29 21:08:57.958121 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-559cb857 tst