Run Test: slices-bi-singlenode-login 2026-06-21 17:15:18.658982 CEST - Run: /usr/local/bin/uv pip compile --upgrade /tmp/tmptsx101j_.package_name --index=https://doc.slices-ri.eu/pypi/ 2026-06-21 17:15:22.882509 CEST - Run: /usr/local/bin/uv pip sync /opt/slices-monitor-worker/slices_monitor_tests/ca3afdfa-ddff-4afb-ac52-50884f5e2e31/pip_compile_update_slices-cli.txt --index=https://doc.slices-ri.eu/pypi/ 2026-06-21 17:15:27.657872 CEST - Run: slices --version 2026-06-21 17:15:27.922775 CEST - version: Slices CLI v2026.1.2 Slices CLI core v1.2.4 Slices CLI ai v1.1.0 Slices CLI bi v2.2.0 Slices clientlib bi v6.1.1 Slices clientlib ai v1.0.0 Slices clientlib core v5.5.1 2026-06-21 17:15:27.923164 CEST - Run: slices pubkey list --format text 2026-06-21 17:15:28.538891 CEST - Pubkey already registered 2026-06-21 17:15:28.539215 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-06-21 17:15:29.154710 CEST - Refreshed infrastructure list. Total: 23 entries. 2026-06-21 17:15:29.154883 CEST - Check List Flavors 2026-06-21 17:15:29.155076 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 flavor list -f json 2026-06-21 17:15:29.821189 CEST - Check List DiskImages 2026-06-21 17:15:29.821420 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 diskimage list -f json 2026-06-21 17:15:30.487301 CEST - Requesting resources 2026-06-21 17:15:30.487748 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 create tst --image 'Ubuntu 24.04.3' --flavor pc --duration 2h --experiment tst-d9bf8946 2026-06-21 17:15:32.456057 CEST - Resource ID: r_be-gent1-bi-baremetal1_01kvnc0ktaf7gr87bh4c1f9ksm 2026-06-21 17:15:32.456200 CEST - Waiting until resource ready 2026-06-21 17:15:34.456515 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 list-resources --format json --experiment tst-d9bf8946 tst 2026-06-21 17:15:35.171907 CEST - Status: IMAGING 2026-06-21 17:15:37.837818 CEST - Status: IMAGING 2026-06-21 17:15:40.503497 CEST - Status: IMAGING 2026-06-21 17:15:43.269340 CEST - Status: IMAGING 2026-06-21 17:15:46.085403 CEST - Status: IMAGING 2026-06-21 17:15:48.801162 CEST - Status: IMAGING 2026-06-21 17:15:51.567201 CEST - Status: IMAGING 2026-06-21 17:15:54.333003 CEST - Status: IMAGING 2026-06-21 17:15:57.306295 CEST - Status: IMAGING 2026-06-21 17:16:00.021925 CEST - Status: IMAGING 2026-06-21 17:16:02.950301 CEST - Status: IMAGING 2026-06-21 17:16:05.816931 CEST - Status: IMAGING 2026-06-21 17:16:08.883266 CEST - Status: IMAGING 2026-06-21 17:16:11.598959 CEST - Status: IMAGING 2026-06-21 17:16:14.314851 CEST - Status: IMAGING 2026-06-21 17:16:17.080650 CEST - Status: IMAGING 2026-06-21 17:16:19.847064 CEST - Status: IMAGING 2026-06-21 17:16:22.562969 CEST - Status: IMAGING 2026-06-21 17:16:25.279110 CEST - Status: UP 2026-06-21 17:16:25.279203 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kvnc0k4sfzr9j7xzvc96h7rn 2026-06-21 17:16:25.279246 CEST - Validate resources 2026-06-21 17:16:26.044876 CEST - The fields of the created resource were validated. 2026-06-21 17:16:26.044960 CEST - Check if resources are registered in experiment 2026-06-21 17:16:26.045111 CEST - Run: slices experiment list-resources --format json tst-d9bf8946 2026-06-21 17:16:26.660214 CEST - Status (on expauth): UP 2026-06-21 17:16:26.660362 CEST - Testing extend expires_at (all resources in experiment) 2026-06-21 17:16:26.660508 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 extend --duration 3h --experiment tst-d9bf8946 2026-06-21 17:16:30.633452 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 list-resources --format json --experiment tst-d9bf8946 tst 2026-06-21 17:16:31.349211 CEST - Run: slices experiment list-resources --format json tst-d9bf8946 2026-06-21 17:16:31.964614 CEST - expires_at (on expauth): 2026-06-21T18:16:00Z (correctly extended) 2026-06-21 17:16:31.964702 CEST - Testing extend expires_at (single resource in experiment) 2026-06-21 17:16:31.964902 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 extend tst --duration 4h --experiment tst-d9bf8946 2026-06-21 17:16:37.441624 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 list-resources --format json --experiment tst-d9bf8946 tst 2026-06-21 17:16:38.257758 CEST - Run: slices experiment list-resources --format json tst-d9bf8946 2026-06-21 17:16:38.873039 CEST - expires_at (on expauth): 2026-06-21T19:16:00Z (correctly extended) 2026-06-21 17:16:38.873160 CEST - Testing ssh login 2026-06-21 17:16:38.882963 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-d9bf8946 tst 2026-06-21 17:16:39.598901 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-d9bf8946 tst 2026-06-21 17:16:40.266291 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-d9bf8946 tst 2026-06-21 17:16:40.931684 CEST - Logging in using 'slices bi ssh' 2026-06-21 17:16:40.931751 CEST - Forcing IPv4 only. 2026-06-21 17:16:40.931874 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-d9bf8946 tst -- -4 uname -a 2026-06-21 17:16:41.948306 CEST - Forcing IPv4 only. 2026-06-21 17:16:41.948530 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-d9bf8946 tst -- -4 uptime 2026-06-21 17:16:42.814572 CEST - CLI SSH Test passed. 2026-06-21 17:16:42.814644 CEST - Uname: Linux tst.y7bdv0.fed4fire-eu.wall1.ilabt.imec.be 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-06-21 17:16:42.814662 CEST - Uptime: 17:16:42 up 0 min, 1 user, load average: 0.12, 0.03, 0.01 2026-06-21 17:16:42.814688 CEST - Logging in using 'slices bi ssh' 2026-06-21 17:16:42.814736 CEST - Forcing IPv6 only. 2026-06-21 17:16:42.814860 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-d9bf8946 tst -- -6 uname -a 2026-06-21 17:16:43.680715 CEST - Forcing IPv6 only. 2026-06-21 17:16:43.680941 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-d9bf8946 tst -- -6 uptime 2026-06-21 17:16:44.496710 CEST - CLI SSH Test passed. 2026-06-21 17:16:44.496813 CEST - Uname: Linux tst.y7bdv0.fed4fire-eu.wall1.ilabt.imec.be 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-06-21 17:16:44.496831 CEST - Uptime: 17:16:44 up 0 min, 1 user, load average: 0.11, 0.03, 0.01 2026-06-21 17:16:44.496865 CEST - Logging in using SSH (extra test: ignore SSH proxy) 2026-06-21 17:16:44.497315 CEST - Added paramiko HostKeyEntry for n075-11.wall1.ilabt.imec.be 2026-06-21 17:16:44.497539 CEST - Added paramiko HostKeyEntry for n075-11.wall1.ilabt.imec.be 2026-06-21 17:16:44.497629 CEST - Added paramiko HostKeyEntry for n075-11.wall1.ilabt.imec.be 2026-06-21 17:16:44.497799 CEST - Connecting to n075-11.wall1.ilabt.imec.be:22 2026-06-21 17:16:44.842615 CEST - SSH Test output: 2026-06-21 17:16:44.842684 CEST - Uname: Linux tst.y7bdv0.fed4fire-eu.wall1.ilabt.imec.be 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-06-21 17:16:44.842704 CEST - Uptime: 17:16:44 up 0 min, 1 user, load average: 0.11, 0.03, 0.01 2026-06-21 17:16:44.904067 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-06-21 17:16:44.904144 CEST - lsb_release matches expected value 2026-06-21 17:16:44.904161 CEST - SSH Test passed. 2026-06-21 17:16:44.904233 CEST - Logging in using SSH over SSH proxy 2026-06-21 17:16:44.904387 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-d9bf8946 tst 2026-06-21 17:16:45.572648 CEST - Added paramiko HostKeyEntry for n075-11.wall1.ilabt.imec.be 2026-06-21 17:16:45.572826 CEST - Added paramiko HostKeyEntry for n075-11.wall1.ilabt.imec.be 2026-06-21 17:16:45.572876 CEST - Added paramiko HostKeyEntry for n075-11.wall1.ilabt.imec.be 2026-06-21 17:16:45.573087 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-06-21 17:16:45.573134 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-06-21 17:16:45.573232 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-06-21 17:16:45.573248 CEST - Connecting to proxy bastion2.slices-be.eu:22 2026-06-21 17:16:45.837470 CEST - Connecting to n075-11.wall1.ilabt.imec.be:22 over proxy 2026-06-21 17:16:46.159132 CEST - SSH Test output: 2026-06-21 17:16:46.159205 CEST - Uname: Linux tst.y7bdv0.fed4fire-eu.wall1.ilabt.imec.be 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-06-21 17:16:46.159221 CEST - Uptime: 17:16:46 up 0 min, 2 users, load average: 0.11, 0.03, 0.01 2026-06-21 17:16:46.234107 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-06-21 17:16:46.234179 CEST - lsb_release matches expected value 2026-06-21 17:16:46.234203 CEST - SSH Test passed. 2026-06-21 17:16:46.240492 CEST - Destroying tst-d9bf8946 tst 2026-06-21 17:16:46.240658 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 destroy --experiment tst-d9bf8946 tst 2026-06-21 17:17:46.250148 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/ca3afdfa-ddff-4afb-ac52-50884f5e2e31/step_Destroy_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra be-gent1-bi-baremetal1 destroy --experiment tst-d9bf8946 tst 2026-06-21 17:17:46.250307 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/ca3afdfa-ddff-4afb-ac52-50884f5e2e31/destroy.txt': 10.0% / task starting 10.0% - task starting 30.0% \ task starting 30.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting ***Terminating process due to timeout*** ***Process terminated*** 2026-06-21 17:17:46.250369 CEST - Error in test step 'Destroy': "slices bi destroy" failed (return value is -15) 2026-06-21 17:17:46.250409 CEST - Step 'Destroy' took 60.01 seconds, which is longer than the warning threshold of 15 seconds