18/05/2025 07:52:17 | MainThread | root | INFO | (logger.configure_logging|line:127) | Operating system: Linux-6.8.0-57-generic-x86_64-with-glibc2.39 | 18/05/2025 07:52:17 | MainThread | root | INFO | (logger.configure_logging|line:128) | Python version: 3.12.3 | 18/05/2025 07:52:17 | MainThread | SetEnvs | INFO | (ci.__init__|line:129) | ENVIRONMENT DATA: NODE_NAME: 'X86-BUILDER-1a --contabo' IMAGE: 'linuxserver/grocy' BASE: 'alpine' META_TAG: 'v4.5.0-ls293' RELEASE_TAG: 'latest' TAGS: 'amd64-v4.5.0-ls293|arm64v8-v4.5.0-ls293' S6_VERBOSITY: '2' CI_S6_VERBOSITY 'None' CI_LOG_LEVEL 'None' DOCKER_ENV: '' DOCKER_VOLUMES: 'None' (Not in use) DOCKER_PRIVILEGED: 'None' (Not in use) WEB_AUTH: '' WEB_PATH: '' WEB_SCREENSHOT: 'true' WEB_SCREENSHOT_TIMEOUT: 'None' WEB_SCREENSHOT_DELAY: 'None' DOCKER_LOGS_TIMEOUT: '60' SBOM_TIMEOUT: 'None' DELAY_START: 'None' (Not in use) PORT: '80' SSL: 'false' S3_REGION: 'None' S3_BUCKET: 'None' Docker Engine Version: '28.0.4' | 18/05/2025 07:52:17 | AMD64Thread | LSIO CI | INFO | (ci.container_test|line:299) | Starting test of: amd64-v4.5.0-ls293 | 18/05/2025 07:52:17 | ARM64Thread | LSIO CI | INFO | (ci.container_test|line:299) | Starting test of: arm64v8-v4.5.0-ls293 | 18/05/2025 07:52:17 | ARM64Thread | LSIO CI | INFO | (ci.container_test|line:304) | Container config of tag arm64v8-v4.5.0-ls293: ['PATH=/lsiopy/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', 'PS1=$(whoami)@$(hostname):$(pwd)\\$ ', 'HOME=/root', 'TERM=xterm', 'S6_CMD_WAIT_FOR_SERVICES_MAXTIME=0', 'S6_VERBOSITY=1', 'S6_STAGE2_HOOK=/docker-mods', 'VIRTUAL_ENV=/lsiopy', 'PHP_INI_SCAN_DIR=:/config/php', 'LSIO_FIRST_PARTY=true'] | 18/05/2025 07:52:17 | ARM64Thread_1 | LSIO CI | INFO | (ci.watch_container_logs|line:614) | Tailing the arm64v8-v4.5.0-ls293 logs for 60 seconds looking for the 'done' message | 18/05/2025 07:52:18 | AMD64Thread | LSIO CI | INFO | (ci.container_test|line:304) | Container config of tag amd64-v4.5.0-ls293: ['PATH=/lsiopy/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', 'PS1=$(whoami)@$(hostname):$(pwd)\\$ ', 'HOME=/root', 'TERM=xterm', 'S6_CMD_WAIT_FOR_SERVICES_MAXTIME=0', 'S6_VERBOSITY=1', 'S6_STAGE2_HOOK=/docker-mods', 'VIRTUAL_ENV=/lsiopy', 'PHP_INI_SCAN_DIR=:/config/php', 'LSIO_FIRST_PARTY=true'] | 18/05/2025 07:52:18 | AMD64Thread_1 | LSIO CI | INFO | (ci.watch_container_logs|line:614) | Tailing the amd64-v4.5.0-ls293 logs for 60 seconds looking for the 'done' message | 18/05/2025 07:52:18 | ARM64Thread_0 | LSIO CI | INFO | (ci.generate_sbom|line:457) | Creating SBOM package list on arm64v8-v4.5.0-ls293 | 18/05/2025 07:52:18 | ARM64Thread_0 | LSIO CI | INFO | (ci.generate_sbom|line:460) | Tailing the syft container logs for 900 seconds looking the 'VERSION' message on tag: arm64v8-v4.5.0-ls293 | 18/05/2025 07:52:18 | AMD64Thread_0 | LSIO CI | INFO | (ci.generate_sbom|line:457) | Creating SBOM package list on amd64-v4.5.0-ls293 | 18/05/2025 07:52:18 | AMD64Thread_0 | LSIO CI | INFO | (ci.generate_sbom|line:460) | Tailing the syft container logs for 900 seconds looking the 'VERSION' message on tag: amd64-v4.5.0-ls293 | 18/05/2025 07:52:20 | AMD64Thread_1 | LSIO CI | INFO | (ci.watch_container_logs|line:619) | Container startup completed for amd64-v4.5.0-ls293 | 18/05/2025 07:52:20 | AMD64Thread_1 | LSIO CI | SUCCESS | (ci.watch_container_logs|line:621) | Container startup amd64-v4.5.0-ls293: PASSED after 2.02 seconds | 18/05/2025 07:52:34 | ARM64Thread_1 | LSIO CI | INFO | (ci.watch_container_logs|line:619) | Container startup completed for arm64v8-v4.5.0-ls293 | 18/05/2025 07:52:34 | ARM64Thread_1 | LSIO CI | SUCCESS | (ci.watch_container_logs|line:621) | Container startup arm64v8-v4.5.0-ls293: PASSED after 16.17 seconds | 18/05/2025 07:52:38 | ARM64Thread_0 | LSIO CI | INFO | (ci.generate_sbom|line:467) | Get package versions for arm64v8-v4.5.0-ls293 completed | 18/05/2025 07:52:38 | ARM64Thread_0 | LSIO CI | SUCCESS | (ci.generate_sbom|line:469) | Create SBOM package list arm64v8-v4.5.0-ls293: PASSED after 20.52 seconds | 18/05/2025 07:52:38 | ARM64Thread_0 | LSIO CI | INFO | (ci.create_html_ansi_file|line:714) | Creating arm64v8-v4.5.0-ls293.sbom.html | 18/05/2025 07:52:38 | AMD64Thread_0 | LSIO CI | INFO | (ci.generate_sbom|line:467) | Get package versions for amd64-v4.5.0-ls293 completed | 18/05/2025 07:52:38 | AMD64Thread_0 | LSIO CI | SUCCESS | (ci.generate_sbom|line:469) | Create SBOM package list amd64-v4.5.0-ls293: PASSED after 20.50 seconds | 18/05/2025 07:52:38 | AMD64Thread_0 | LSIO CI | INFO | (ci.create_html_ansi_file|line:714) | Creating amd64-v4.5.0-ls293.sbom.html | 18/05/2025 07:52:38 | ARM64Thread | LSIO CI | INFO | (ci.get_build_info|line:579) | Fetching build info on tag: arm64v8-v4.5.0-ls293 | 18/05/2025 07:52:38 | AMD64Thread | LSIO CI | INFO | (ci.get_build_info|line:579) | Fetching build info on tag: amd64-v4.5.0-ls293 | 18/05/2025 07:52:38 | ARM64Thread | LSIO CI | SUCCESS | (ci.get_build_info|line:590) | Get build info on tag 'arm64v8-v4.5.0-ls293': PASS | 18/05/2025 07:52:38 | ARM64Thread | LSIO CI | INFO | (ci.setup_driver|line:902) | Init Chromedriver | 18/05/2025 07:52:38 | AMD64Thread | LSIO CI | SUCCESS | (ci.get_build_info|line:590) | Get build info on tag 'amd64-v4.5.0-ls293': PASS | 18/05/2025 07:52:38 | AMD64Thread | LSIO CI | INFO | (ci.setup_driver|line:902) | Init Chromedriver | 18/05/2025 07:52:39 | AMD64Thread | LSIO CI | INFO | (ci.take_screenshot|line:805) | Trying for 120 seconds to take a screenshot of amd64-v4.5.0-ls293 | 18/05/2025 07:52:39 | ARM64Thread | LSIO CI | INFO | (ci.take_screenshot|line:805) | Trying for 120 seconds to take a screenshot of arm64v8-v4.5.0-ls293 | 18/05/2025 07:52:50 | ARM64Thread | LSIO CI | WARNING | (ci._check_response|line:862) | Failed to get a good response on http://172.17.0.4:80 |'Traceback (most recent call last):\n File "/lsiopy/lib/python3.12/site-packages/urllib3/connectionpool.py", line 468, in _make_request\n six.raise_from(e, None)\n File "<string>", line 3, in raise_from\n File "/lsiopy/lib/python3.12/site-packages/urllib3/connectionpool.py", line 463, in _make_request\n httplib_response = conn.getresponse()\n ^^^^^^^^^^^^^^^^^^\n File "/usr/lib/python3.12/http/client.py", line 1428, in getresponse\n response.begin()\n File "/usr/lib/python3.12/http/client.py", line 331, in begin\n version, status, reason = self._read_status()\n ^^^^^^^^^^^^^^^^^^^\n File "/usr/lib/python3.12/http/client.py", line 292, in _read_status\n line = str(self.fp.readline(_MAXLINE + 1), "iso-8859-1")\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/usr/lib/python3.12/socket.py", line 707, in readinto\n return self._sock.recv_into(b)\n ^^^^^^^^^^^^^^^^^^^^^^^\nTimeoutError: timed out\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/lsiopy/lib/python3.12/site-packages/requests/adapters.py", line 489, in send\n resp = conn.urlopen(\n ^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/urllib3/connectionpool.py", line 802, in urlopen\n retries = retries.increment(\n ^^^^^^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/urllib3/util/retry.py", line 552, in increment\n raise six.reraise(type(error), error, _stacktrace)\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/urllib3/packages/six.py", line 770, in reraise\n raise value\n File "/lsiopy/lib/python3.12/site-packages/urllib3/connectionpool.py", line 716, in urlopen\n httplib_response = self._make_request(\n ^^^^^^^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/urllib3/connectionpool.py", line 470, in _make_request\n self._raise_timeout(err=e, url=url, timeout_value=read_timeout)\n File "/lsiopy/lib/python3.12/site-packages/urllib3/connectionpool.py", line 358, in _raise_timeout\n raise ReadTimeoutError(\nurllib3.exceptions.ReadTimeoutError: HTTPConnectionPool(host=\'172.17.0.4\', port=80): Read timed out. (read timeout=10)\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/ci/ci.py", line 858, in _check_response\n response = requests.get(endpoint, timeout=10, verify=False)\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/requests/api.py", line 73, in get\n return request("get", url, params=params, **kwargs)\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/requests/api.py", line 59, in request\n return session.request(method=method, url=url, **kwargs)\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/requests/sessions.py", line 587, in request\n resp = self.send(prep, **send_kwargs)\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/requests/sessions.py", line 723, in send\n history = [resp for resp in gen]\n ^^^^^^^^^^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/requests/sessions.py", line 266, in resolve_redirects\n resp = self.send(\n ^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/requests/sessions.py", line 701, in send\n r = adapter.send(request, **kwargs)\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/lsiopy/lib/python3.12/site-packages/requests/adapters.py", line 578, in send\n raise ReadTimeout(e, request=request)\nrequests.exceptions.ReadTimeout: HTTPConnectionPool(host=\'172.17.0.4\', port=80): Read timed out. (read timeout=10)'| 18/05/2025 07:52:52 | AMD64Thread | LSIO CI | SUCCESS | (ci.take_screenshot|line:817) | Screenshot amd64-v4.5.0-ls293: PASSED after 14.08 seconds | 18/05/2025 07:52:52 | AMD64Thread | LSIO CI | INFO | (ci.create_html_ansi_file|line:714) | Creating amd64-v4.5.0-ls293.log.html | 18/05/2025 07:52:53 | AMD64Thread | LSIO CI | SUCCESS | (ci.container_test|line:338) | Test of amd64-v4.5.0-ls293 PASSED after 35.59 seconds | 18/05/2025 07:53:05 | ARM64Thread | LSIO CI | SUCCESS | (ci.take_screenshot|line:817) | Screenshot arm64v8-v4.5.0-ls293: PASSED after 26.89 seconds | 18/05/2025 07:53:05 | ARM64Thread | LSIO CI | INFO | (ci.create_html_ansi_file|line:714) | Creating arm64v8-v4.5.0-ls293.log.html | 18/05/2025 07:53:05 | ARM64Thread | LSIO CI | SUCCESS | (ci.container_test|line:338) | Test of arm64v8-v4.5.0-ls293 PASSED after 48.38 seconds | 18/05/2025 07:53:06 | MainThread | __main__ | SUCCESS | (test_build.run_test|line:16) | All tests PASSED after 48.53 seconds | 18/05/2025 07:53:06 | MainThread | LSIO CI | INFO | (ci.report_render|line:637) | Rendering Report | 18/05/2025 07:53:06 | MainThread | LSIO CI | INFO | (ci.badge_render|line:656) | Creating badge | 18/05/2025 07:53:06 | MainThread | LSIO CI | INFO | (ci.json_render|line:668) | Creating report.json file | 18/05/2025 07:53:06 | MainThread | LSIO CI | INFO | (ci.report_upload|line:683) | Uploading report files | 18/05/2025 07:53:06 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/favicon.ico to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:07 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/amd64-v4.5.0-ls293.sbom.html to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:08 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/ci-status.yml to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:08 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/404.jpg to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:09 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/arm64v8-v4.5.0-ls293.sbom.html to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:10 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/ci.log to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:11 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/arm64v8-v4.5.0-ls293.png to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:11 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/logo.jpg to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:12 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/amd64-v4.5.0-ls293.log.html to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:13 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/amd64-v4.5.0-ls293.png to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:14 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/report.json to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:15 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/index.html to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:15 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/badge.svg to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:16 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/arm64v8-v4.5.0-ls293.log.html to ci-tests.linuxserver.io bucket | 18/05/2025 07:53:16 | MainThread | LSIO CI | INFO | (ci.report_upload|line:701) | Report available on https://ci-tests.linuxserver.io/linuxserver/grocy/v4.5.0-ls293/index.html | 18/05/2025 07:53:16 | MainThread | LSIO CI | INFO | (ci.log_upload|line:748) | Uploading logs | 18/05/2025 07:53:16 | MainThread | LSIO CI | INFO | (ci.upload_file|line:735) | Uploading /ci/output/linuxserver/grocy/v4.5.0-ls293/ci.log to ci-tests.linuxserver.io bucket |