13/07/2025 16:38:07 | MainThread | root | INFO | (logger.configure_logging|line:127) | Operating system: Linux-6.1.0-28-amd64-x86_64-with-glibc2.39 | 13/07/2025 16:38:07 | MainThread | root | INFO | (logger.configure_logging|line:128) | Python version: 3.12.3 | 13/07/2025 16:38:07 | MainThread | SetEnvs | INFO | (ci.convert_env|line:197) | Converting envs 'TZ=US/Pacific' to dictionary | 13/07/2025 16:38:07 | MainThread | SetEnvs | INFO | (ci.__init__|line:143) | ENVIRONMENT DATA: NODE_NAME: 'X86-BUILDER-3k --Hetzner' IMAGE: 'linuxserver/dolphin' BASE: 'ubuntu' META_TAG: '4d66a716-ls8' RELEASE_TAG: 'latest' TAGS: 'amd64-4d66a716-ls8|arm64v8-4d66a716-ls8' S6_VERBOSITY: '2' CI_S6_VERBOSITY 'None' CI_LOG_LEVEL 'None' DOCKER_ENV: 'TZ=US/Pacific' DOCKER_VOLUMES: 'None' (Not in use) DOCKER_PRIVILEGED: 'None' (Not in use) WEB_AUTH: 'user:password' WEB_PATH: '' WEB_SCREENSHOT: 'true' WEB_SCREENSHOT_TIMEOUT: 'None' WEB_SCREENSHOT_DELAY: 'None' DOCKER_LOGS_TIMEOUT: '120' SBOM_TIMEOUT: 'None' DELAY_START: 'None' (Not in use) PORT: '3001' SSL: 'true' S3_REGION: 'None' S3_BUCKET: 'None' SYFT_IMAGE_TAG: 'v1.26.1' Docker Engine Version: '28.2.2' | 13/07/2025 16:38:07 | AMD64Thread | LSIO CI | INFO | (ci.container_test|line:313) | Starting test of: amd64-4d66a716-ls8 | 13/07/2025 16:38:07 | ARM64Thread | LSIO CI | INFO | (ci.container_test|line:313) | Starting test of: arm64v8-4d66a716-ls8 | 13/07/2025 16:38:08 | ARM64Thread | LSIO CI | INFO | (ci.container_test|line:319) | Container config of tag arm64v8-4d66a716-ls8: ['TZ=US/Pacific', 'S6_VERBOSITY=2', 'PATH=/lsiopy/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', 'HOME=/config', 'LANGUAGE=en_US.UTF-8', 'LANG=en_US.UTF-8', 'TERM=xterm', 'S6_CMD_WAIT_FOR_SERVICES_MAXTIME=0', 'S6_STAGE2_HOOK=/docker-mods', 'VIRTUAL_ENV=/lsiopy', 'DISPLAY=:1', 'PERL5LIB=/usr/local/bin', 'START_DOCKER=true', 'PULSE_RUNTIME_PATH=/defaults', 'SELKIES_INTERPOSER=/usr/lib/selkies_joystick_interposer.so', 'NVIDIA_DRIVER_CAPABILITIES=all', 'DISABLE_ZINK=false', 'TITLE=Dolphin', 'LSIO_FIRST_PARTY=true'] | 13/07/2025 16:38:08 | ARM64Thread_1 | LSIO CI | INFO | (ci.watch_container_logs|line:651) | Tailing the arm64v8-4d66a716-ls8 logs for 120 seconds looking for the 'done' message | 13/07/2025 16:38:08 | AMD64Thread | LSIO CI | INFO | (ci.container_test|line:319) | Container config of tag amd64-4d66a716-ls8: ['TZ=US/Pacific', 'S6_VERBOSITY=2', 'PATH=/lsiopy/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', 'HOME=/config', 'LANGUAGE=en_US.UTF-8', 'LANG=en_US.UTF-8', 'TERM=xterm', 'S6_CMD_WAIT_FOR_SERVICES_MAXTIME=0', 'S6_STAGE2_HOOK=/docker-mods', 'VIRTUAL_ENV=/lsiopy', 'DISPLAY=:1', 'PERL5LIB=/usr/local/bin', 'START_DOCKER=true', 'PULSE_RUNTIME_PATH=/defaults', 'SELKIES_INTERPOSER=/usr/lib/selkies_joystick_interposer.so', 'NVIDIA_DRIVER_CAPABILITIES=all', 'DISABLE_ZINK=false', 'TITLE=Dolphin', 'LSIO_FIRST_PARTY=true'] | 13/07/2025 16:38:09 | AMD64Thread_1 | LSIO CI | INFO | (ci.watch_container_logs|line:651) | Tailing the amd64-4d66a716-ls8 logs for 120 seconds looking for the 'done' message | 13/07/2025 16:38:09 | ARM64Thread_0 | LSIO CI | INFO | (ci.generate_sbom|line:494) | Creating SBOM package list on arm64v8-4d66a716-ls8 with syft version v1.26.1 | 13/07/2025 16:38:09 | ARM64Thread_0 | LSIO CI | INFO | (ci.generate_sbom|line:497) | Tailing the syft container logs for 900 seconds looking the 'VERSION' message on tag: arm64v8-4d66a716-ls8 | 13/07/2025 16:38:09 | AMD64Thread_0 | LSIO CI | INFO | (ci.generate_sbom|line:494) | Creating SBOM package list on amd64-4d66a716-ls8 with syft version v1.26.1 | 13/07/2025 16:38:09 | AMD64Thread_0 | LSIO CI | INFO | (ci.generate_sbom|line:497) | Tailing the syft container logs for 900 seconds looking the 'VERSION' message on tag: amd64-4d66a716-ls8 | 13/07/2025 16:38:10 | AMD64Thread_1 | LSIO CI | INFO | (ci.watch_container_logs|line:656) | Container startup completed for amd64-4d66a716-ls8 | 13/07/2025 16:38:10 | AMD64Thread_1 | LSIO CI | SUCCESS | (ci.watch_container_logs|line:658) | Container startup amd64-4d66a716-ls8: PASSED after 1.01 seconds | 13/07/2025 16:38:23 | ARM64Thread_1 | LSIO CI | INFO | (ci.watch_container_logs|line:656) | Container startup completed for arm64v8-4d66a716-ls8 | 13/07/2025 16:38:23 | ARM64Thread_1 | LSIO CI | SUCCESS | (ci.watch_container_logs|line:658) | Container startup arm64v8-4d66a716-ls8: PASSED after 15.07 seconds | 13/07/2025 16:39:34 | ARM64Thread_0 | LSIO CI | INFO | (ci.generate_sbom|line:504) | Get package versions for arm64v8-4d66a716-ls8 completed | 13/07/2025 16:39:34 | ARM64Thread_0 | LSIO CI | SUCCESS | (ci.generate_sbom|line:506) | Create SBOM package list arm64v8-4d66a716-ls8: PASSED after 86.02 seconds | 13/07/2025 16:39:34 | ARM64Thread_0 | LSIO CI | INFO | (ci.create_html_ansi_file|line:751) | Creating arm64v8-4d66a716-ls8.sbom.html | 13/07/2025 16:39:39 | AMD64Thread_0 | LSIO CI | INFO | (ci.generate_sbom|line:504) | Get package versions for amd64-4d66a716-ls8 completed | 13/07/2025 16:39:39 | AMD64Thread_0 | LSIO CI | SUCCESS | (ci.generate_sbom|line:506) | Create SBOM package list amd64-4d66a716-ls8: PASSED after 90.96 seconds | 13/07/2025 16:39:39 | AMD64Thread_0 | LSIO CI | INFO | (ci.create_html_ansi_file|line:751) | Creating amd64-4d66a716-ls8.sbom.html | 13/07/2025 16:39:47 | ARM64Thread | LSIO CI | INFO | (ci.get_build_info|line:616) | Fetching build info on tag: arm64v8-4d66a716-ls8 | 13/07/2025 16:39:47 | ARM64Thread | LSIO CI | SUCCESS | (ci.get_build_info|line:627) | Get build info on tag 'arm64v8-4d66a716-ls8': PASS | 13/07/2025 16:39:47 | ARM64Thread | LSIO CI | INFO | (ci.setup_driver|line:949) | Init Chromedriver | 13/07/2025 16:39:48 | ARM64Thread | LSIO CI | INFO | (ci.take_screenshot|line:845) | Trying for 120 seconds to take a screenshot of arm64v8-4d66a716-ls8 | 13/07/2025 16:39:54 | AMD64Thread | LSIO CI | INFO | (ci.get_build_info|line:616) | Fetching build info on tag: amd64-4d66a716-ls8 | 13/07/2025 16:39:54 | AMD64Thread | LSIO CI | SUCCESS | (ci.get_build_info|line:627) | Get build info on tag 'amd64-4d66a716-ls8': PASS | 13/07/2025 16:39:54 | AMD64Thread | LSIO CI | INFO | (ci.setup_driver|line:949) | Init Chromedriver | 13/07/2025 16:39:55 | AMD64Thread | LSIO CI | INFO | (ci.take_screenshot|line:845) | Trying for 120 seconds to take a screenshot of amd64-4d66a716-ls8 | 13/07/2025 16:40:00 | ARM64Thread | LSIO CI | SUCCESS | (ci.take_screenshot|line:857) | Screenshot arm64v8-4d66a716-ls8: PASSED after 12.60 seconds | 13/07/2025 16:40:00 | ARM64Thread | LSIO CI | INFO | (ci._get_browser_logs|line:411) | Getting browser console logs for tag arm64v8-4d66a716-ls8 | 13/07/2025 16:40:00 | ARM64Thread | LSIO CI | INFO | (ci.create_html_ansi_file|line:751) | Creating arm64v8-4d66a716-ls8.browser.html | 13/07/2025 16:40:00 | ARM64Thread | LSIO CI | INFO | (ci.create_html_ansi_file|line:751) | Creating arm64v8-4d66a716-ls8.log.html | 13/07/2025 16:40:07 | AMD64Thread | LSIO CI | SUCCESS | (ci.take_screenshot|line:857) | Screenshot amd64-4d66a716-ls8: PASSED after 12.95 seconds | 13/07/2025 16:40:07 | AMD64Thread | LSIO CI | INFO | (ci._get_browser_logs|line:411) | Getting browser console logs for tag amd64-4d66a716-ls8 | 13/07/2025 16:40:07 | AMD64Thread | LSIO CI | INFO | (ci.create_html_ansi_file|line:751) | Creating amd64-4d66a716-ls8.browser.html | 13/07/2025 16:40:07 | AMD64Thread | LSIO CI | INFO | (ci.create_html_ansi_file|line:751) | Creating amd64-4d66a716-ls8.log.html | 13/07/2025 16:40:20 | AMD64Thread | LSIO CI | ERROR | (ci._endtest|line:377) | Failed to remove container amd64-4d66a716-ls8 |'Traceback (most recent call last):\n File "/lsiopy/lib/python3.12/site-packages/docker/api/client.py", line 268, in _raise_for_status\n response.raise_for_status()\n File "/lsiopy/lib/python3.12/site-packages/requests/models.py", line 1021, in raise_for_status\n raise HTTPError(http_error_msg, response=self)\nrequests.exceptions.HTTPError: 500 Server Error: Internal Server Error for url: http+docker://localhost/v1.50/containers/40d2932d462a3551ae344aed8805e45978431fa8f8b697bc36e02322cba7256b?v=False&link=False&force=true\n\nThe above exception was the direct cause of the following exception:\n\nTraceback (most recent call last):\n File "/ci/ci.py", line 375, in _endtest\n container.remove(force="true")\n File "/lsiopy/lib/python3.12/site-packages/docker/models/containers.py", line 352, in remove\n return self.client.api.remove_container(self.id, **kwargs)\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/docker/utils/decorators.py", line 19, in wrapped\n return f(self, resource_id, *args, **kwargs)\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/docker/api/container.py", line 1027, in remove_container\n self._raise_for_status(res)\n File "/lsiopy/lib/python3.12/site-packages/docker/api/client.py", line 270, in _raise_for_status\n raise create_api_error_from_http_exception(e) from e\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/docker/errors.py", line 39, in create_api_error_from_http_exception\n raise cls(e, response=response, explanation=explanation) from e\ndocker.errors.APIError: 500 Server Error for http+docker://localhost/v1.50/containers/40d2932d462a3551ae344aed8805e45978431fa8f8b697bc36e02322cba7256b?v=False&link=False&force=true: Internal Server Error ("cannot remove container "40d2932d462a3551ae344aed8805e45978431fa8f8b697bc36e02322cba7256b": could not kill container: tried to kill container, but did not receive an exit event")'| 13/07/2025 16:40:20 | AMD64Thread | LSIO CI | SUCCESS | (ci.container_test|line:353) | Test of amd64-4d66a716-ls8 PASSED after 132.51 seconds | 13/07/2025 16:40:43 | ARM64Thread | LSIO CI | SUCCESS | (ci.container_test|line:353) | Test of arm64v8-4d66a716-ls8 PASSED after 155.64 seconds | 13/07/2025 16:40:43 | MainThread | __main__ | SUCCESS | (test_build.run_test|line:16) | All tests PASSED after 155.78 seconds | 13/07/2025 16:40:43 | MainThread | LSIO CI | INFO | (ci.report_render|line:674) | Rendering Report | 13/07/2025 16:40:43 | MainThread | LSIO CI | INFO | (ci.badge_render|line:693) | Creating badge | 13/07/2025 16:40:43 | MainThread | LSIO CI | INFO | (ci.json_render|line:705) | Creating report.json file | 13/07/2025 16:40:43 | MainThread | LSIO CI | INFO | (ci.report_upload|line:720) | Uploading report files | 13/07/2025 16:40:43 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/report.json to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:45 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/amd64-4d66a716-ls8.sbom.html to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:46 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/404.jpg to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:47 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/arm64v8-4d66a716-ls8.browser.html to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:49 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/ci.log to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:49 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/amd64-4d66a716-ls8.log.html to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:51 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/favicon.ico to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:52 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/badge.svg to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:53 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/index.html to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:54 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/arm64v8-4d66a716-ls8.sbom.html to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:55 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/arm64v8-4d66a716-ls8.png to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:56 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/logo.jpg to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:57 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/amd64-4d66a716-ls8.png to ci-tests.linuxserver.io bucket | 13/07/2025 16:40:59 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/arm64v8-4d66a716-ls8.log.html to ci-tests.linuxserver.io bucket | 13/07/2025 16:41:00 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/amd64-4d66a716-ls8.browser.html to ci-tests.linuxserver.io bucket | 13/07/2025 16:41:01 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/ci-status.yml to ci-tests.linuxserver.io bucket | 13/07/2025 16:41:01 | MainThread | LSIO CI | INFO | (ci.report_upload|line:738) | Report available on https://ci-tests.linuxserver.io/linuxserver/dolphin/4d66a716-ls8/index.html | 13/07/2025 16:41:01 | MainThread | LSIO CI | INFO | (ci.log_upload|line:780) | Uploading logs | 13/07/2025 16:41:01 | MainThread | LSIO CI | INFO | (ci.upload_file|line:772) | Uploading /ci/output/linuxserver/dolphin/4d66a716-ls8/ci.log to ci-tests.linuxserver.io bucket |