Run Test: slices-bi-singlenode-login 2026-01-26 16:00:35.029383 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-01-26 16:00:39.064889 CET - Run: slices --version 2026-01-26 16:00:39.254201 CET - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.1.5 Slices clientlib bi v5.0.6 2026-01-26 16:00:39.254480 CET - Run: slices pubkey list --format text 2026-01-26 16:00:39.939516 CET - Pubkey already registered 2026-01-26 16:00:39.939792 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-01-26 16:00:40.433138 CET - Refreshed infrastructure list. Total: 20 entries. 2026-01-26 16:00:40.433261 CET - Check List Flavors 2026-01-26 16:00:40.433466 CET - Run: slices bi --infra be-gent1-bi-baremetal1 flavor list -f json 2026-01-26 16:00:41.142459 CET - Check List DiskImages 2026-01-26 16:00:41.142708 CET - Run: slices bi --infra be-gent1-bi-baremetal1 diskimage list -f json 2026-01-26 16:00:41.650689 CET - Requesting resources 2026-01-26 16:00:41.651244 CET - Run: slices bi --infra be-gent1-bi-baremetal1 create tst --image 'Ubuntu 24.04.3' --flavor pc --duration 2h --experiment tst-451cf0f4 2026-01-26 16:00:43.549601 CET - Resource ID: r_be-gent1-bi-baremetal1_01kfxd4hsje68rcnxydg6m317b 2026-01-26 16:00:43.549728 CET - Waiting until resource ready 2026-01-26 16:00:45.550109 CET - Run: slices bi --infra be-gent1-bi-baremetal1 list-resources --format json --experiment tst-451cf0f4 tst 2026-01-26 16:00:46.147536 CET - Status: IMAGING 2026-01-26 16:00:48.727397 CET - Status: IMAGING 2026-01-26 16:00:51.306739 CET - Status: IMAGING 2026-01-26 16:00:57.102918 CET - Status: IMAGING 2026-01-26 16:00:59.908384 CET - Status: IMAGING 2026-01-26 16:01:02.684584 CET - Status: IMAGING 2026-01-26 16:01:05.495843 CET - Status: IMAGING 2026-01-26 16:01:08.314219 CET - Status: IMAGING 2026-01-26 16:01:11.112798 CET - Status: IMAGING 2026-01-26 16:01:13.902699 CET - Status: IMAGING 2026-01-26 16:01:16.704686 CET - Status: IMAGING 2026-01-26 16:01:19.506236 CET - Status: IMAGING 2026-01-26 16:01:22.278395 CET - Status: IMAGING 2026-01-26 16:01:25.074068 CET - Status: IMAGING 2026-01-26 16:01:27.884372 CET - Status: IMAGING 2026-01-26 16:01:30.672511 CET - Status: IMAGING 2026-01-26 16:01:33.461698 CET - Status: IMAGING 2026-01-26 16:01:36.245630 CET - Status: IMAGING 2026-01-26 16:01:39.055333 CET - Status: IMAGING 2026-01-26 16:01:41.812355 CET - Status: IMAGING 2026-01-26 16:01:44.578173 CET - Status: IMAGING 2026-01-26 16:01:47.339674 CET - Status: IMAGING 2026-01-26 16:01:50.193411 CET - Status: IMAGING 2026-01-26 16:01:53.188292 CET - Status: IMAGING 2026-01-26 16:01:56.124144 CET - Status: IMAGING 2026-01-26 16:01:59.021230 CET - Status: IMAGING 2026-01-26 16:02:01.835166 CET - Status: IMAGING 2026-01-26 16:02:04.626946 CET - Status: IMAGING 2026-01-26 16:02:07.430974 CET - Status: IMAGING 2026-01-26 16:02:10.236335 CET - Status: IMAGING 2026-01-26 16:02:13.055853 CET - Status: IMAGING 2026-01-26 16:02:15.892824 CET - Status: IMAGING 2026-01-26 16:02:18.691950 CET - Status: IMAGING 2026-01-26 16:02:21.463907 CET - Status: IMAGING 2026-01-26 16:02:24.290526 CET - Status: IMAGING 2026-01-26 16:02:27.100252 CET - Status: IMAGING 2026-01-26 16:02:29.896243 CET - Status: IMAGING 2026-01-26 16:02:32.723917 CET - Status: IMAGING 2026-01-26 16:02:35.525313 CET - Status: IMAGING 2026-01-26 16:02:38.316829 CET - Status: IMAGING 2026-01-26 16:02:41.119989 CET - Status: IMAGING 2026-01-26 16:02:43.928844 CET - Status: IMAGING 2026-01-26 16:02:46.705495 CET - Status: IMAGING 2026-01-26 16:02:49.566005 CET - Status: IMAGING 2026-01-26 16:02:52.372467 CET - Status: IMAGING 2026-01-26 16:02:55.180708 CET - Status: IMAGING 2026-01-26 16:02:57.936753 CET - Status: IMAGING 2026-01-26 16:03:00.693758 CET - Status: IMAGING 2026-01-26 16:03:03.462392 CET - Status: IMAGING 2026-01-26 16:03:06.307607 CET - Status: IMAGING 2026-01-26 16:03:09.096560 CET - Status: IMAGING 2026-01-26 16:03:11.858276 CET - Status: IMAGING 2026-01-26 16:03:14.627484 CET - Status: IMAGING 2026-01-26 16:03:17.424873 CET - Status: IMAGING 2026-01-26 16:03:20.216168 CET - Status: IMAGING 2026-01-26 16:03:23.000646 CET - Status: IMAGING 2026-01-26 16:03:25.759716 CET - Status: IMAGING 2026-01-26 16:03:28.523842 CET - Status: IMAGING 2026-01-26 16:03:31.302512 CET - Status: IMAGING 2026-01-26 16:03:34.067398 CET - Status: IMAGING 2026-01-26 16:03:36.829220 CET - Status: IMAGING 2026-01-26 16:03:39.591685 CET - Status: IMAGING 2026-01-26 16:03:42.374179 CET - Status: IMAGING 2026-01-26 16:03:45.138623 CET - Status: IMAGING 2026-01-26 16:03:47.909592 CET - Status: IMAGING 2026-01-26 16:03:50.674613 CET - Status: IMAGING 2026-01-26 16:03:53.441947 CET - Status: IMAGING 2026-01-26 16:03:56.213152 CET - Status: IMAGING 2026-01-26 16:03:59.006033 CET - Status: IMAGING 2026-01-26 16:04:01.804914 CET - Status: IMAGING 2026-01-26 16:04:04.579527 CET - Status: IMAGING 2026-01-26 16:04:07.349842 CET - Status: IMAGING 2026-01-26 16:04:10.106550 CET - Status: IMAGING 2026-01-26 16:04:12.896097 CET - Status: IMAGING 2026-01-26 16:04:15.673985 CET - Status: IMAGING 2026-01-26 16:04:18.476447 CET - Status: IMAGING 2026-01-26 16:04:21.243757 CET - Status: IMAGING 2026-01-26 16:04:24.038457 CET - Status: IMAGING 2026-01-26 16:04:26.820639 CET - Status: IMAGING 2026-01-26 16:04:29.636287 CET - Status: IMAGING 2026-01-26 16:04:32.414224 CET - Status: IMAGING 2026-01-26 16:04:35.237113 CET - Status: IMAGING 2026-01-26 16:04:38.054059 CET - Status: IMAGING 2026-01-26 16:04:40.824062 CET - Status: IMAGING 2026-01-26 16:04:43.620789 CET - Status: IMAGING 2026-01-26 16:04:46.390623 CET - Status: IMAGING 2026-01-26 16:04:49.177475 CET - Status: IMAGING 2026-01-26 16:04:51.939929 CET - Status: IMAGING 2026-01-26 16:04:54.719911 CET - Status: IMAGING 2026-01-26 16:05:00.020278 CET - Status: IMAGING 2026-01-26 16:05:02.774584 CET - Status: IMAGING 2026-01-26 16:05:05.578061 CET - Status: IMAGING 2026-01-26 16:05:08.389356 CET - Status: IMAGING 2026-01-26 16:05:11.178254 CET - Status: IMAGING 2026-01-26 16:05:13.927590 CET - Status: IMAGING 2026-01-26 16:05:16.693542 CET - Status: IMAGING 2026-01-26 16:05:19.472156 CET - Status: IMAGING 2026-01-26 16:05:22.239227 CET - Status: IMAGING 2026-01-26 16:05:25.071524 CET - Status: IMAGING 2026-01-26 16:05:27.889236 CET - Status: IMAGING 2026-01-26 16:05:30.712013 CET - Status: IMAGING 2026-01-26 16:05:33.532014 CET - Status: IMAGING 2026-01-26 16:05:36.363004 CET - Status: IMAGING 2026-01-26 16:05:39.173892 CET - Status: IMAGING 2026-01-26 16:05:41.994923 CET - Status: IMAGING 2026-01-26 16:05:44.837794 CET - Status: IMAGING 2026-01-26 16:05:47.662699 CET - Status: IMAGING 2026-01-26 16:05:50.472736 CET - Status: IMAGING 2026-01-26 16:05:53.284570 CET - Status: IMAGING 2026-01-26 16:05:56.092411 CET - Status: IMAGING 2026-01-26 16:05:58.896565 CET - Status: IMAGING 2026-01-26 16:06:01.704136 CET - Status: IMAGING 2026-01-26 16:06:04.506025 CET - Status: IMAGING 2026-01-26 16:06:07.270029 CET - Status: IMAGING 2026-01-26 16:06:10.041443 CET - Status: IMAGING 2026-01-26 16:06:12.855188 CET - Status: IMAGING 2026-01-26 16:06:15.661155 CET - Status: IMAGING 2026-01-26 16:06:18.464245 CET - Status: IMAGING 2026-01-26 16:06:21.264846 CET - Status: IMAGING 2026-01-26 16:06:24.082466 CET - Status: IMAGING 2026-01-26 16:06:26.882396 CET - Status: IMAGING 2026-01-26 16:06:29.692127 CET - Status: IMAGING 2026-01-26 16:06:32.504234 CET - Status: IMAGING 2026-01-26 16:06:35.310180 CET - Status: IMAGING 2026-01-26 16:06:38.107828 CET - Status: IMAGING 2026-01-26 16:06:40.900696 CET - Status: IMAGING 2026-01-26 16:06:43.685407 CET - Status: IMAGING 2026-01-26 16:06:46.455924 CET - Status: IMAGING 2026-01-26 16:06:49.245256 CET - Status: IMAGING 2026-01-26 16:06:52.022144 CET - Status: IMAGING 2026-01-26 16:06:54.831122 CET - Status: IMAGING 2026-01-26 16:06:57.643905 CET - Status: IMAGING 2026-01-26 16:07:00.452029 CET - Status: IMAGING 2026-01-26 16:07:03.243950 CET - Status: IMAGING 2026-01-26 16:07:06.046905 CET - Status: IMAGING 2026-01-26 16:07:08.835093 CET - Status: IMAGING 2026-01-26 16:07:11.634038 CET - Status: IMAGING 2026-01-26 16:07:14.450126 CET - Status: IMAGING 2026-01-26 16:07:17.253108 CET - Status: IMAGING 2026-01-26 16:07:20.083832 CET - Status: IMAGING 2026-01-26 16:07:22.874615 CET - Status: IMAGING 2026-01-26 16:07:25.685109 CET - Status: IMAGING 2026-01-26 16:07:28.618885 CET - Status: IMAGING 2026-01-26 16:07:31.424994 CET - Status: IMAGING 2026-01-26 16:07:34.230095 CET - Status: IMAGING 2026-01-26 16:07:37.037740 CET - Status: IMAGING 2026-01-26 16:07:39.805286 CET - Status: IMAGING 2026-01-26 16:07:42.568170 CET - Status: IMAGING 2026-01-26 16:07:45.336353 CET - Status: IMAGING 2026-01-26 16:07:48.137989 CET - Status: IMAGING 2026-01-26 16:07:50.911335 CET - Status: IMAGING 2026-01-26 16:07:53.667744 CET - Status: IMAGING 2026-01-26 16:07:56.432360 CET - Status: IMAGING 2026-01-26 16:07:59.217393 CET - Status: IMAGING 2026-01-26 16:08:01.976171 CET - Status: IMAGING 2026-01-26 16:08:04.736312 CET - Status: IMAGING 2026-01-26 16:08:07.493873 CET - Status: IMAGING 2026-01-26 16:08:10.257082 CET - Status: IMAGING 2026-01-26 16:08:13.019879 CET - Status: IMAGING 2026-01-26 16:08:15.789339 CET - Status: IMAGING 2026-01-26 16:08:18.568375 CET - Status: IMAGING 2026-01-26 16:08:21.341495 CET - Status: IMAGING 2026-01-26 16:08:24.154985 CET - Status: IMAGING 2026-01-26 16:08:26.960408 CET - Status: IMAGING 2026-01-26 16:08:29.765885 CET - Status: IMAGING 2026-01-26 16:08:32.581359 CET - Status: IMAGING 2026-01-26 16:08:35.388760 CET - Status: IMAGING 2026-01-26 16:08:38.199492 CET - Status: IMAGING 2026-01-26 16:08:41.011974 CET - Status: IMAGING 2026-01-26 16:08:43.861551 CET - Status: IMAGING 2026-01-26 16:08:46.633789 CET - Status: IMAGING 2026-01-26 16:08:49.470237 CET - Status: IMAGING 2026-01-26 16:08:52.284379 CET - Status: IMAGING 2026-01-26 16:08:55.101077 CET - Status: IMAGING 2026-01-26 16:08:57.905612 CET - Status: IMAGING 2026-01-26 16:09:03.405737 CET - Status: IMAGING 2026-01-26 16:09:06.220566 CET - Status: IMAGING 2026-01-26 16:09:09.044022 CET - Status: IMAGING 2026-01-26 16:09:11.863472 CET - Status: IMAGING 2026-01-26 16:09:14.696024 CET - Status: IMAGING 2026-01-26 16:09:17.491784 CET - Status: IMAGING 2026-01-26 16:09:20.264668 CET - Status: IMAGING 2026-01-26 16:09:23.033930 CET - Status: IMAGING 2026-01-26 16:09:25.809882 CET - Status: IMAGING 2026-01-26 16:09:28.575156 CET - Status: IMAGING 2026-01-26 16:09:31.337225 CET - Status: IMAGING 2026-01-26 16:09:34.127181 CET - Status: IMAGING 2026-01-26 16:09:36.905237 CET - Status: IMAGING 2026-01-26 16:09:39.678206 CET - Status: IMAGING 2026-01-26 16:09:42.439940 CET - Status: IMAGING 2026-01-26 16:09:45.201665 CET - Status: IMAGING 2026-01-26 16:09:47.957203 CET - Status: IMAGING 2026-01-26 16:09:50.719355 CET - Status: IMAGING 2026-01-26 16:09:53.530697 CET - Status: IMAGING 2026-01-26 16:09:56.419952 CET - Status: IMAGING 2026-01-26 16:09:59.200778 CET - Status: IMAGING 2026-01-26 16:10:01.975833 CET - Status: IMAGING 2026-01-26 16:10:04.774847 CET - Status: STARTING 2026-01-26 16:10:07.541455 CET - Status: UP 2026-01-26 16:10:07.541498 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kfxd4h48edgs5fkcsk55bb23 2026-01-26 16:10:07.541532 CET - Check if resources are registered in experiment 2026-01-26 16:10:07.541729 CET - Run: slices experiment list-resources --format json tst-451cf0f4 2026-01-26 16:10:08.155147 CET - Status (on expauth): UP 2026-01-26 16:10:08.155274 CET - Testing extend expires_at (all resources in experiment) 2026-01-26 16:10:08.155418 CET - Run: slices bi --infra be-gent1-bi-baremetal1 extend --duration 3h --experiment tst-451cf0f4 2026-01-26 16:10:13.037279 CET - Run: slices bi --infra be-gent1-bi-baremetal1 list-resources --format json --experiment tst-451cf0f4 tst 2026-01-26 16:10:13.788504 CET - Testing extend expires_at (single resource in experiment) 2026-01-26 16:10:13.788682 CET - Run: slices bi --infra be-gent1-bi-baremetal1 extend tst --duration 4h --experiment tst-451cf0f4 2026-01-26 16:10:17.620323 CET - Run: slices bi --infra be-gent1-bi-baremetal1 list-resources --format json --experiment tst-451cf0f4 tst 2026-01-26 16:10:18.398866 CET - Testing ssh login 2026-01-26 16:10:18.419242 CET - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-451cf0f4 tst 2026-01-26 16:10:19.047664 CET - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-451cf0f4 tst 2026-01-26 16:10:19.648784 CET - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-451cf0f4 tst 2026-01-26 16:10:20.248464 CET - Logging in using 'slices bi ssh' 2026-01-26 16:10:20.248565 CET - Forcing IPv4 only. 2026-01-26 16:10:20.248736 CET - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-451cf0f4 tst -- -4 uname -a 2026-01-26 16:10:21.125177 CET - Forcing IPv4 only. 2026-01-26 16:10:21.125323 CET - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-451cf0f4 tst -- -4 uptime 2026-01-26 16:10:21.867110 CET - CLI SSH Test passed. 2026-01-26 16:10:21.867148 CET - Uname: Linux tst.spfyi8.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-01-26 16:10:21.867157 CET - Uptime: 16:10:21 up 0 min, 1 user, load average: 0.00, 0.00, 0.00 2026-01-26 16:10:21.867178 CET - Logging in using 'slices bi ssh' 2026-01-26 16:10:21.867230 CET - Forcing IPv6 only. 2026-01-26 16:10:21.867343 CET - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-451cf0f4 tst -- -6 uname -a 2026-01-26 16:10:22.617649 CET - Forcing IPv6 only. 2026-01-26 16:10:22.617793 CET - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-451cf0f4 tst -- -6 uptime 2026-01-26 16:10:23.359113 CET - CLI SSH Test passed. 2026-01-26 16:10:23.359154 CET - Uname: Linux tst.spfyi8.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-01-26 16:10:23.359164 CET - Uptime: 16:10:23 up 0 min, 1 user, load average: 0.00, 0.00, 0.00 2026-01-26 16:10:23.359188 CET - Logging in using SSH (extra test: ignore SSH proxy) 2026-01-26 16:10:23.359579 CET - Added paramiko HostKeyEntry for n074-09.wall1.ilabt.imec.be 2026-01-26 16:10:23.359715 CET - Added paramiko HostKeyEntry for n074-09.wall1.ilabt.imec.be 2026-01-26 16:10:23.359758 CET - Added paramiko HostKeyEntry for n074-09.wall1.ilabt.imec.be 2026-01-26 16:10:23.359917 CET - Connecting to n074-09.wall1.ilabt.imec.be:22 2026-01-26 16:10:23.698303 CET - SSH Test output: 2026-01-26 16:10:23.698348 CET - Uname: Linux tst.spfyi8.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-01-26 16:10:23.698359 CET - Uptime: 16:10:23 up 0 min, 1 user, load average: 0.00, 0.00, 0.00 2026-01-26 16:10:23.752912 CET - lsb_release: Ubuntu 24.04.3 LTS 2026-01-26 16:10:23.752956 CET - lsb_release matches expected value 2026-01-26 16:10:23.752965 CET - SSH Test passed. 2026-01-26 16:10:23.753036 CET - Logging in using SSH over SSH proxy 2026-01-26 16:10:23.753179 CET - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-451cf0f4 tst 2026-01-26 16:10:24.363513 CET - Added paramiko HostKeyEntry for n074-09.wall1.ilabt.imec.be 2026-01-26 16:10:24.363626 CET - Added paramiko HostKeyEntry for n074-09.wall1.ilabt.imec.be 2026-01-26 16:10:24.363660 CET - Added paramiko HostKeyEntry for n074-09.wall1.ilabt.imec.be 2026-01-26 16:10:24.363883 CET - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-01-26 16:10:24.363920 CET - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-01-26 16:10:24.364008 CET - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-01-26 16:10:24.364019 CET - Connecting to proxy bastion2.slices-be.eu:22 2026-01-26 16:10:26.281129 CET - Connecting to n074-09.wall1.ilabt.imec.be:22 over proxy 2026-01-26 16:10:26.586637 CET - SSH Test output: 2026-01-26 16:10:26.586680 CET - Uname: Linux tst.spfyi8.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-01-26 16:10:26.586690 CET - Uptime: 16:10:26 up 0 min, 2 users, load average: 0.00, 0.00, 0.00 2026-01-26 16:10:26.668475 CET - lsb_release: Ubuntu 24.04.3 LTS 2026-01-26 16:10:26.668523 CET - lsb_release matches expected value 2026-01-26 16:10:26.668533 CET - SSH Test passed. 2026-01-26 16:10:26.674951 CET - Destroying tst-451cf0f4 tst 2026-01-26 16:10:26.675104 CET - Run: slices bi --infra be-gent1-bi-baremetal1 destroy --experiment tst-451cf0f4 tst