Test run: - Start at Fri Oct 16 14:00:25 UTC 2026 - Docker image: "monitor-test-runner:scli-manual-manual" - Container name: "test-run-6d92c35e-0d8f-456b-a6ac-50a5c7958a61" - 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.79ms Installed 1 package in 1ms Run Test: slices-bi-singlenode-login 2026-10-16 14:00:29.202153 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-10-16 14:00:29.206333 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-10-16 14:00:29.206407 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-10-16 14:00:29.206575 UTC - which slices: /usr/local/bin/slices 2026-10-16 14:00:29.206603 UTC - Slices CLI exe: 'slices' 2026-10-16 14:00:29.206819 UTC - Run: slices --version 2026-10-16 14:00:33.031015 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-10-16 14:00:33.031700 UTC - Run: slices pubkey list --format text 2026-10-16 14:00:34.248203 UTC - Pubkey already registered 2026-10-16 14:00:34.249236 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-10-16 14:00:34.964910 UTC - Refreshed infrastructure list. Total: 25 entries. 2026-10-16 14:00:34.965027 UTC - Check List Flavors 2026-10-16 14:00:34.965223 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-10-16 14:00:35.731312 UTC - Check List DiskImages 2026-10-16 14:00:35.731553 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-10-16 14:00:36.448158 UTC - Requesting resources 2026-10-16 14:00:36.448887 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian13-min --flavor nova --duration 2h --experiment tst-4a63d9f3 2026-10-16 14:00:37.967559 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01m52g7hjkfws9d1fxe9zdzvsg 2026-10-16 14:00:37.967798 UTC - Waiting until resource ready 2026-10-16 14:00:39.968317 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-4a63d9f3 tst 2026-10-16 14:00:40.887580 UTC - Status: IMAGING 2026-10-16 14:00:43.754402 UTC - Status: IMAGING 2026-10-16 14:00:46.679651 UTC - Status: IMAGING 2026-10-16 14:00:49.495906 UTC - Status: IMAGING 2026-10-16 14:00:52.313283 UTC - Status: IMAGING 2026-10-16 14:00:55.130309 UTC - Status: STARTING 2026-10-16 14:00:57.946873 UTC - Status: STARTING 2026-10-16 14:01:00.813409 UTC - Status: STARTING 2026-10-16 14:01:03.680007 UTC - Status: STARTING 2026-10-16 14:01:06.546943 UTC - Status: STARTING 2026-10-16 14:01:09.468535 UTC - Status: STARTING 2026-10-16 14:01:12.284794 UTC - Status: STARTING 2026-10-16 14:01:15.101231 UTC - Status: STARTING 2026-10-16 14:01:17.918382 UTC - Status: STARTING 2026-10-16 14:01:20.735099 UTC - Status: STARTING 2026-10-16 14:01:23.551584 UTC - Status: STARTING 2026-10-16 14:01:26.370947 UTC - Status: STARTING 2026-10-16 14:01:29.238099 UTC - Status: STARTING 2026-10-16 14:01:32.054825 UTC - Status: STARTING 2026-10-16 14:01:34.821293 UTC - Status: STARTING 2026-10-16 14:01:37.637933 UTC - Status: STARTING 2026-10-16 14:01:40.454434 UTC - Status: STARTING 2026-10-16 14:01:43.270962 UTC - Status: STARTING 2026-10-16 14:01:46.087668 UTC - Status: STARTING 2026-10-16 14:01:48.854126 UTC - Status: STARTING 2026-10-16 14:01:51.721495 UTC - Status: STARTING 2026-10-16 14:01:54.588587 UTC - Status: STARTING 2026-10-16 14:01:57.455995 UTC - Status: STARTING 2026-10-16 14:02:00.272709 UTC - Status: STARTING 2026-10-16 14:02:03.089565 UTC - Status: STARTING 2026-10-16 14:02:05.906425 UTC - Status: STARTING 2026-10-16 14:02:08.773726 UTC - Status: STARTING 2026-10-16 14:02:11.590826 UTC - Status: STARTING 2026-10-16 14:02:14.407475 UTC - Status: STARTING 2026-10-16 14:02:17.224485 UTC - Status: STARTING 2026-10-16 14:02:20.042191 UTC - Status: STARTING 2026-10-16 14:02:22.858713 UTC - Status: STARTING 2026-10-16 14:02:25.675674 UTC - Status: STARTING 2026-10-16 14:02:28.442340 UTC - Status: STARTING 2026-10-16 14:02:31.359725 UTC - Status: STARTING 2026-10-16 14:02:34.176486 UTC - Status: STARTING 2026-10-16 14:02:36.993385 UTC - Status: STARTING 2026-10-16 14:02:39.810093 UTC - Status: STARTING 2026-10-16 14:02:42.576490 UTC - Status: STARTING 2026-10-16 14:02:45.393243 UTC - Status: STARTING 2026-10-16 14:02:48.209787 UTC - Status: STARTING 2026-10-16 14:02:51.026570 UTC - Status: STARTING 2026-10-16 14:02:53.843389 UTC - Status: STARTING 2026-10-16 14:02:56.609795 UTC - Status: STARTING 2026-10-16 14:02:59.426475 UTC - Status: STARTING 2026-10-16 14:03:02.243715 UTC - Status: STARTING 2026-10-16 14:03:05.010423 UTC - Status: STARTING 2026-10-16 14:03:07.827356 UTC - Status: STARTING 2026-10-16 14:03:10.644096 UTC - Status: STARTING 2026-10-16 14:03:13.461552 UTC - Status: STARTING 2026-10-16 14:03:16.278150 UTC - Status: STARTING 2026-10-16 14:03:19.094841 UTC - Status: STARTING 2026-10-16 14:03:22.012637 UTC - Status: STARTING 2026-10-16 14:03:24.880972 UTC - Status: STARTING 2026-10-16 14:03:27.747760 UTC - Status: UP 2026-10-16 14:03:27.747855 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01m52g7h4nfy9rcg9kpf8kzp3v 2026-10-16 14:03:27.747901 UTC - Validate resources 2026-10-16 14:03:28.564444 UTC - The fields of the created resource were validated. 2026-10-16 14:03:28.564559 UTC - Check if resources are registered in experiment 2026-10-16 14:03:28.564755 UTC - Run: slices experiment list-resources --format json tst-4a63d9f3 2026-10-16 14:03:29.280636 UTC - Status (on expauth): UP 2026-10-16 14:03:29.280814 UTC - Testing extend expires_at (all resources in experiment) 2026-10-16 14:03:29.280979 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-4a63d9f3 2026-10-16 14:03:33.104282 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-4a63d9f3 tst 2026-10-16 14:03:33.920689 UTC - Run: slices experiment list-resources --format json tst-4a63d9f3 2026-10-16 14:03:34.586416 UTC - expires_at (on expauth): 2026-10-16T17:03:00Z (correctly extended) 2026-10-16 14:03:34.586515 UTC - Testing extend expires_at (single resource in experiment) 2026-10-16 14:03:34.586678 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-4a63d9f3 2026-10-16 14:03:38.310165 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-4a63d9f3 tst 2026-10-16 14:03:39.126363 UTC - Run: slices experiment list-resources --format json tst-4a63d9f3 2026-10-16 14:03:39.792105 UTC - expires_at (on expauth): 2026-10-16T18:03:00Z (correctly extended) 2026-10-16 14:03:39.792231 UTC - Testing ssh login 2026-10-16 14:03:39.807376 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-4a63d9f3 tst 2026-10-16 14:03:40.625208 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-4a63d9f3 tst 2026-10-16 14:03:41.441485 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-4a63d9f3 tst 2026-10-16 14:03:42.207471 UTC - Logging in using 'slices bi ssh' 2026-10-16 14:03:42.207552 UTC - Forcing IPv4 only. 2026-10-16 14:03:42.207679 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-4a63d9f3 tst -- -4 uname -a 2026-10-16 14:03:44.878479 UTC - Forcing IPv4 only. 2026-10-16 14:03:44.878677 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-4a63d9f3 tst -- -4 uptime 2026-10-16 14:03:46.246127 UTC - CLI SSH Test passed. 2026-10-16 14:03:46.246233 UTC - Uname: Linux nova-23 6.12.111+deb13-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.111-1 (2026-09-28) x86_64 GNU/Linux 2026-10-16 14:03:46.246267 UTC - Uptime: 16:03:46 up 0 min, 1 user, load average: 2.01, 0.71, 0.25 2026-10-16 14:03:46.246317 UTC - Logging in using 'slices bi ssh' 2026-10-16 14:03:46.246383 UTC - Forcing IPv6 only. 2026-10-16 14:03:46.246581 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-4a63d9f3 tst -- -6 uname -a 2026-10-16 14:03:47.614639 UTC - Forcing IPv6 only. 2026-10-16 14:03:47.614917 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-4a63d9f3 tst -- -6 uptime 2026-10-16 14:03:48.982583 UTC - CLI SSH Test passed. 2026-10-16 14:03:48.982661 UTC - Uname: Linux nova-23 6.12.111+deb13-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.111-1 (2026-09-28) x86_64 GNU/Linux 2026-10-16 14:03:48.982681 UTC - Uptime: 16:03:49 up 0 min, 1 user, load average: 2.01, 0.71, 0.25 2026-10-16 14:03:48.982718 UTC - Logging in using SSH over SSH proxy 2026-10-16 14:03:48.982859 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-4a63d9f3 tst 2026-10-16 14:03:49.850301 UTC - Added paramiko HostKeyEntry for nova-23.lyon 2026-10-16 14:03:49.850505 UTC - Added paramiko HostKeyEntry for nova-23.lyon 2026-10-16 14:03:49.850566 UTC - Added paramiko HostKeyEntry for nova-23.lyon 2026-10-16 14:03:49.850831 UTC - Added paramiko HostKeyEntry for access.grid5000.fr 2026-10-16 14:03:49.850932 UTC - Added paramiko HostKeyEntry for access.grid5000.fr 2026-10-16 14:03:49.850977 UTC - Added paramiko HostKeyEntry for access.grid5000.fr 2026-10-16 14:03:49.850995 UTC - Connecting to proxy access.grid5000.fr:22 2026-10-16 14:03:50.188332 UTC - Connecting to nova-23.lyon:22 over proxy 2026-10-16 14:03:50.668517 UTC - SSH Test output: 2026-10-16 14:03:50.668614 UTC - Uname: Linux nova-23 6.12.111+deb13-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.111-1 (2026-09-28) x86_64 GNU/Linux 2026-10-16 14:03:50.668636 UTC - Uptime: 16:03:50 up 1 min, 1 user, load average: 1.85, 0.70, 0.25 2026-10-16 14:03:50.778478 UTC - lsb_release: Debian GNU/Linux 13 (trixie) 2026-10-16 14:03:50.875813 UTC - /etc/debian_version: 13.7 2026-10-16 14:03:50.875915 UTC - lsb_release matches expected value 2026-10-16 14:03:50.875938 UTC - /etc/debian_version matches expected value 2026-10-16 14:03:50.875954 UTC - SSH Test passed. 2026-10-16 14:03:50.883180 UTC - Destroying tst-4a63d9f3 tst 2026-10-16 14:03:50.883385 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-4a63d9f3 tst