Run Test: slices-bi-singlenode-login 2026-04-19 17:39:03.749057 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-19 17:39:07.069734 CEST - Run: slices --version 2026-04-19 17:39:07.284025 CEST - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.5.0 Slices clientlib bi v5.1.2 2026-04-19 17:39:07.284306 CEST - Run: slices pubkey list --format text 2026-04-19 17:39:07.899269 CEST - Pubkey already registered 2026-04-19 17:39:07.899486 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-19 17:39:08.414377 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-19 17:39:08.414498 CEST - Check List Flavors 2026-04-19 17:39:08.414684 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 flavor list -f json 2026-04-19 17:39:09.130010 CEST - Check List DiskImages 2026-04-19 17:39:09.130209 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 diskimage list -f json 2026-04-19 17:39:09.795393 CEST - Requesting resources 2026-04-19 17:39:09.795848 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-04-19 17:39:09.795946 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-ea6e9c4b --user-data /tmp/tmp8ltt626_ 2026-04-19 17:39:11.763817 CEST - Resource ID: r_fr-sophia2-bi-vm1_01kpk6amtbehh9f3y5t0f77z58 2026-04-19 17:39:11.763939 CEST - Waiting until resource ready 2026-04-19 17:39:13.764314 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-ea6e9c4b tst 2026-04-19 17:39:14.479512 CEST - Status: IMAGING 2026-04-19 17:39:17.245084 CEST - Status: IMAGING 2026-04-19 17:39:20.010954 CEST - Status: IMAGING 2026-04-19 17:39:22.726476 CEST - Status: BOOTING 2026-04-19 17:39:25.492134 CEST - Status: BOOTING 2026-04-19 17:39:28.257842 CEST - Status: BOOTING 2026-04-19 17:39:31.023514 CEST - Status: BOOTING 2026-04-19 17:39:33.739311 CEST - Status: BOOTING 2026-04-19 17:39:36.504951 CEST - Status: BOOTING 2026-04-19 17:39:39.270785 CEST - Status: BOOTING 2026-04-19 17:39:42.036591 CEST - Status: BOOTING 2026-04-19 17:39:44.802179 CEST - Status: BOOTING 2026-04-19 17:39:47.567800 CEST - Status: BOOTING 2026-04-19 17:39:50.333481 CEST - Status: BOOTING 2026-04-19 17:39:53.099008 CEST - Status: BOOTING 2026-04-19 17:39:55.814558 CEST - Status: BOOTING 2026-04-19 17:39:58.580221 CEST - Status: BOOTING 2026-04-19 17:40:01.295784 CEST - Status: BOOTING 2026-04-19 17:40:04.011479 CEST - Status: UP 2026-04-19 17:40:04.011533 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kpk6am0vfzg9qvftz5shcwsm 2026-04-19 17:40:04.011566 CEST - Validate resources 2026-04-19 17:40:04.727267 CEST - The fields of the created resource were validated. 2026-04-19 17:40:04.727340 CEST - Check if resources are registered in experiment 2026-04-19 17:40:04.727505 CEST - Run: slices experiment list-resources --format json tst-ea6e9c4b 2026-04-19 17:40:05.394475 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/e7ec0708-aa02-4689-b1d6-7fd3f23ebc65/step_Checkexperimentprint-resources_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices experiment list-resources --format json tst-ea6e9c4b 2026-04-19 17:40:05.394566 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/e7ec0708-aa02-4689-b1d6-7fd3f23ebc65/experiment-list-resources.txt': /opt/slices-monitor-worker/slices-cli-venv/lib/python3.14/site-packages/authlib/_joserfc_helpers.py:8: AuthlibDeprecationWarning: authlib.jose module is deprecated, please use joserfc instead. It will be compatible before version 2.0.0. from authlib.jose import ECKey [ { "id": "r_fr-sophia2-bi-vm1_01kpk6amtbehh9f3y5t0f77z58", "created_at": "2026-04-19T15:39:11.557402Z", "created_by": "user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g", "experiment_id": "exp_expauth.ilabt.imec.be_01kpk6am0vfzg9qvftz5shcwsm", "friendly_name": "tst", "project_id": "proj_account.ilabt.imec.be_5pzabws7n79ydsagfg3vntg590", "service_id": "bi", "infra_id": "fr-sophia2-bi-vm1", "status": "up", "type": "vm", "description": "Minimal VM", "expires_at": "2026-04-19T17:39:00Z", "terminated_at": null, "terminated_by": null } ] 2026-04-19 17:40:05.394595 CEST - Error in test step 'Check experiment print-resources': "slices experiment list-resources" returned invalid json 2026-04-19 17:40:05.394676 CEST - Testing extend expires_at (all resources in experiment) 2026-04-19 17:40:05.394776 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 extend --duration 3h --experiment tst-ea6e9c4b 2026-04-19 17:40:07.362344 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-ea6e9c4b tst 2026-04-19 17:40:08.077620 CEST - Testing extend expires_at (single resource in experiment) 2026-04-19 17:40:08.077814 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 extend tst --duration 4h --experiment tst-ea6e9c4b 2026-04-19 17:40:09.895519 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-ea6e9c4b tst 2026-04-19 17:40:10.610885 CEST - Testing ssh login 2026-04-19 17:40:10.620436 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-ea6e9c4b tst 2026-04-19 17:40:11.435776 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-ea6e9c4b tst 2026-04-19 17:40:12.251432 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-ea6e9c4b tst 2026-04-19 17:40:13.067155 CEST - Logging in using 'slices bi ssh' 2026-04-19 17:40:13.067225 CEST - Forcing IPv4 only. 2026-04-19 17:40:13.067375 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-ea6e9c4b tst -- -4 uname -a 2026-04-19 17:40:15.736850 CEST - Forcing IPv4 only. 2026-04-19 17:40:15.737016 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-ea6e9c4b tst -- -4 uptime 2026-04-19 17:40:17.303685 CEST - CLI SSH Test passed. 2026-04-19 17:40:17.303769 CEST - Uname: Linux tst 6.8.0-87-generic #88-Ubuntu SMP PREEMPT_DYNAMIC Sat Oct 11 09:28:41 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-04-19 17:40:17.303782 CEST - Uptime: 15:40:17 up 0 min, 1 user, load average: 0.55, 0.15, 0.05 2026-04-19 17:40:17.303810 CEST - Logging in using SSH over SSH proxy 2026-04-19 17:40:17.303954 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-ea6e9c4b tst 2026-04-19 17:40:18.120024 CEST - Added paramiko HostKeyEntry for 10.123.227.43 2026-04-19 17:40:18.120135 CEST - Added paramiko HostKeyEntry for 10.123.227.43 2026-04-19 17:40:18.120291 CEST - Added paramiko HostKeyEntry for 10.123.227.43 2026-04-19 17:40:18.120540 CEST - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-04-19 17:40:18.120622 CEST - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-04-19 17:40:18.120659 CEST - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-04-19 17:40:18.120672 CEST - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-04-19 17:40:18.507896 CEST - Connecting to 10.123.227.43:22 over proxy 2026-04-19 17:40:19.188988 CEST - SSH Test output: 2026-04-19 17:40:19.189035 CEST - Uname: Linux tst 6.8.0-87-generic #88-Ubuntu SMP PREEMPT_DYNAMIC Sat Oct 11 09:28:41 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-04-19 17:40:19.189048 CEST - Uptime: 15:40:19 up 0 min, 1 user, load average: 0.51, 0.15, 0.05 2026-04-19 17:40:19.323782 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-19 17:40:19.323835 CEST - lsb_release matches expected value 2026-04-19 17:40:19.323850 CEST - SSH Test passed. 2026-04-19 17:40:19.458756 CEST - Cloud-init user-data: Hello World. The time is now Sun, 19 Apr 2026 15:39:59 +0000! 2026-04-19 17:40:19.465026 CEST - Destroying tst-ea6e9c4b tst 2026-04-19 17:40:19.465221 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 destroy --experiment tst-ea6e9c4b tst