[taskcluster 2025-02-25T19:38:29.835Z] Worker Type (ap/linux-small) settings:
[taskcluster 2025-02-25T19:38:29.835Z]   {
[taskcluster 2025-02-25T19:38:29.835Z]     "config": {
[taskcluster 2025-02-25T19:38:29.835Z]       "deploymentId": ""
[taskcluster 2025-02-25T19:38:29.835Z]     },
[taskcluster 2025-02-25T19:38:29.835Z]     "generic-worker": {
[taskcluster 2025-02-25T19:38:29.835Z]       "config": {
[taskcluster 2025-02-25T19:38:29.835Z]         "headlessTasks": true
[taskcluster 2025-02-25T19:38:29.835Z]       },
[taskcluster 2025-02-25T19:38:29.835Z]       "engine": "multiuser",
[taskcluster 2025-02-25T19:38:29.835Z]       "go-arch": "amd64",
[taskcluster 2025-02-25T19:38:29.835Z]       "go-os": "linux",
[taskcluster 2025-02-25T19:38:29.835Z]       "go-version": "go1.23.6",
[taskcluster 2025-02-25T19:38:29.835Z]       "release": "https://github.com/taskcluster/taskcluster/releases/tag/v81.0.1",
[taskcluster 2025-02-25T19:38:29.835Z]       "revision": "e69c44b48cfa75020f193cab7ebff1d5c1c8ccf9",
[taskcluster 2025-02-25T19:38:29.835Z]       "source": "https://github.com/taskcluster/taskcluster/commits/e69c44b48cfa75020f193cab7ebff1d5c1c8ccf9",
[taskcluster 2025-02-25T19:38:29.835Z]       "version": "81.0.1"
[taskcluster 2025-02-25T19:38:29.835Z]     }
[taskcluster 2025-02-25T19:38:29.835Z]   }
[taskcluster 2025-02-25T19:38:29.835Z] Task ID: TL1oXaGRSBi8li9zBeyxJg
[taskcluster 2025-02-25T19:38:29.835Z] === Task Starting ===
[taskcluster 2025-02-25T19:38:30.282Z] Uploading redirect artifact public/logs/live.log to URL https://ws.bananium.fr/ci.tc-worker-small-1.60099/log/DLfhiLasRsuERrQd5B1mAA with mime type "text/plain; charset=utf-8" and expiry 2025-02-25T20:38:30.223Z
[taskcluster 2025-02-25T19:38:30.465Z] [mounts] Moving existing writable directory cache ap-level-1-checkouts-v3-593b845d392283aa79ccb7e4c1a451f8 from caches/JXA3Er8KQL-jH913U0psFQ to /home/task_174051091372409/cache0
[taskcluster 2025-02-25T19:38:30.465Z] [mounts] Creating directory /home/task_174051091372409
[taskcluster 2025-02-25T19:38:30.469Z] [mounts] Updating ownership of files inside directory '/home/task_174051091372409/cache0' from task_174050739916506 to task_174051091372409
[taskcluster 2025-02-25T19:38:30.472Z] [mounts] Successfully mounted writable directory cache '/home/task_174051091372409/cache0'
[taskcluster 2025-02-25T19:38:30.472Z] Executing command 0: bash -cx 'docker pull '\''ghcr.io/eijebong/archipelago-yaml-checker:latest'\''
[taskcluster 2025-02-25T19:38:30.472Z] timeout -s KILL 1800 docker run -t --name taskcontainer_ZKq0EPWTSTmgy0oMHl9KNw --memory-swap -1 --pids-limit -1 -v "$(pwd)/cache0:/builds/worker/checkouts" --add-host=taskcluster:127.0.0.1 --net=host -e ARCHIPELAGO_INDEX_BASE_REPOSITORY -e ARCHIPELAGO_INDEX_HEAD_REF -e ARCHIPELAGO_INDEX_HEAD_REPOSITORY -e ARCHIPELAGO_INDEX_HEAD_REV -e ARCHIPELAGO_INDEX_REPOSITORY_TYPE -e GITHUB_PR -e HG_STORE_PATH -e MOZ_AUTOMATION -e MOZ_FETCHES -e MOZ_FETCHES_DIR -e MOZ_SCM_LEVEL -e REPOSITORIES -e RUN_ID -e SCCACHE_DISABLE -e TASKCLUSTER_CACHES -e TASKCLUSTER_INSTANCE_TYPE -e TASKCLUSTER_PROXY_URL -e TASKCLUSTER_ROOT_URL -e TASKCLUSTER_UNTRUSTED_CACHES -e TASKCLUSTER_VOLUMES -e TASKCLUSTER_WORKER_LOCATION -e TASK_GROUP_ID -e TASK_ID -e TEST_ALL -e TEST_APWORLD_NAME -e TEST_APWORLD_VERSION -e TEST_WORLD_NAME -e VCS_PATH '\''ghcr.io/eijebong/archipelago-yaml-checker:latest'\'' /usr/local/bin/run-task --archipelago_index-checkout=/builds/worker/checkouts/vcs/ -- bash -cx '\''cd $VCS_PATH && apwm download -i ./ -d /tmp/download -p "${TEST_APWORLD_NAME}:${TEST_APWORLD_VERSION}" && cd /ap/archipelago && . .venv/bin/activate && unshare -r -n python3 -O /ap/archipelago/self_check.py /ap/supported_worlds /tmp/download "${TEST_APWORLD_NAME}" ${TEST_APWORLD_VERSION} "${TEST_WORLD_NAME}" /builds/worker/'\''
[taskcluster 2025-02-25T19:38:30.472Z] exit_code=$?
[taskcluster 2025-02-25T19:38:30.472Z] docker cp taskcontainer_ZKq0EPWTSTmgy0oMHl9KNw:'\''/builds/worker/template.yaml'\'' '\''artifact0.yaml'\''
[taskcluster 2025-02-25T19:38:30.472Z] docker rm -v taskcontainer_ZKq0EPWTSTmgy0oMHl9KNw
[taskcluster 2025-02-25T19:38:30.472Z] exit "${exit_code}"'
+ docker pull ghcr.io/eijebong/archipelago-yaml-checker:latest
latest: Pulling from eijebong/archipelago-yaml-checker
Digest: sha256:4b05f22a1ab04aa8db70454b717af010b14770df84c8c8b2197fd3ea649cfe6c
Status: Image is up to date for ghcr.io/eijebong/archipelago-yaml-checker:latest
ghcr.io/eijebong/archipelago-yaml-checker:latest
++ pwd
+ timeout -s KILL 1800 docker run -t --name taskcontainer_ZKq0EPWTSTmgy0oMHl9KNw --memory-swap -1 --pids-limit -1 -v /home/task_174051091372409/cache0:/builds/worker/checkouts --add-host=taskcluster:127.0.0.1 --net=host -e ARCHIPELAGO_INDEX_BASE_REPOSITORY -e ARCHIPELAGO_INDEX_HEAD_REF -e ARCHIPELAGO_INDEX_HEAD_REPOSITORY -e ARCHIPELAGO_INDEX_HEAD_REV -e ARCHIPELAGO_INDEX_REPOSITORY_TYPE -e GITHUB_PR -e HG_STORE_PATH -e MOZ_AUTOMATION -e MOZ_FETCHES -e MOZ_FETCHES_DIR -e MOZ_SCM_LEVEL -e REPOSITORIES -e RUN_ID -e SCCACHE_DISABLE -e TASKCLUSTER_CACHES -e TASKCLUSTER_INSTANCE_TYPE -e TASKCLUSTER_PROXY_URL -e TASKCLUSTER_ROOT_URL -e TASKCLUSTER_UNTRUSTED_CACHES -e TASKCLUSTER_VOLUMES -e TASKCLUSTER_WORKER_LOCATION -e TASK_GROUP_ID -e TASK_ID -e TEST_ALL -e TEST_APWORLD_NAME -e TEST_APWORLD_VERSION -e TEST_WORLD_NAME -e VCS_PATH ghcr.io/eijebong/archipelago-yaml-checker:latest /usr/local/bin/run-task --archipelago_index-checkout=/builds/worker/checkouts/vcs/ -- bash -cx 'cd $VCS_PATH && apwm download -i ./ -d /tmp/download -p "${TEST_APWORLD_NAME}:${TEST_APWORLD_VERSION}" && cd /ap/archipelago && . .venv/bin/activate && unshare -r -n python3 -O /ap/archipelago/self_check.py /ap/supported_worlds /tmp/download "${TEST_APWORLD_NAME}" ${TEST_APWORLD_VERSION} "${TEST_WORLD_NAME}" /builds/worker/'
[setup 2025-02-25T19:38:31.272Z] run-task started in /ap
[setup 2025-02-25T19:38:31.272Z] Invoked by command: --archipelago_index-checkout=/builds/worker/checkouts/vcs/ -- bash -cx cd $VCS_PATH && apwm download -i ./ -d /tmp/download -p "${TEST_APWORLD_NAME}:${TEST_APWORLD_VERSION}" && cd /ap/archipelago && . .venv/bin/activate && unshare -r -n python3 -O /ap/archipelago/self_check.py /ap/supported_worlds /tmp/download "${TEST_APWORLD_NAME}" ${TEST_APWORLD_VERSION} "${TEST_WORLD_NAME}" /builds/worker/
[setup 2025-02-25T19:38:31.272Z] Python version: 3.11.2
[cache 2025-02-25T19:38:31.273Z] cache /builds/worker/checkouts exists; requirements: gid=1000 uid=1000 version=1
[volume 2025-02-25T19:38:31.273Z] volume /builds/worker/checkouts is a cache
[setup 2025-02-25T19:38:31.273Z] running as worker:worker
[vcs 2025-02-25T19:38:31.274Z] executing ['git', 'config', '--global', '--add', 'safe.directory', '/builds/worker/checkouts/vcs']
[vcs 2025-02-25T19:38:31.275Z] executing ['git', 'fetch', '--no-tags', 'https://github.com/RePod/Archipelago-index', 'megamix-119']
[vcs 2025-02-25T19:38:31.807Z] From https://github.com/RePod/Archipelago-index
[vcs 2025-02-25T19:38:31.807Z]  * branch            megamix-119 -> FETCH_HEAD
[vcs 2025-02-25T19:38:31.808Z] executing ['git', 'checkout', '-f', '-B', 'megamix-119', '4cad4725779010ab288b03d426af3c8228c8e47b']
[vcs 2025-02-25T19:38:31.811Z] Reset branch 'megamix-119'
[vcs 2025-02-25T19:38:31.811Z] cleaning git checkout...
[vcs 2025-02-25T19:38:31.811Z] executing ['git', 'clean', '-nxdff']
[vcs 2025-02-25T19:38:31.813Z] removing []
[vcs 2025-02-25T19:38:31.813Z] successfully cleaned git checkout!
[vcs 2025-02-25T19:38:31.814Z] TinderboxPrint:<a href='https://github.com/RePod/Archipelago-index/commit/4cad4725779010ab288b03d426af3c8228c8e47b' title='Built from Archipelago-index commit 4cad4725779010ab288b03d426af3c8228c8e47b'>4cad4725779010ab288b03d426af3c8228c8e47b</a>
[setup 2025-02-25T19:38:31.814Z] MOZ_FETCHES_DIR is /ap/fetches
[fetches 2025-02-25T19:38:31.814Z] fetching artifacts
[fetches 2025-02-25T19:38:31.814Z] executing ['/usr/bin/python3', '-u', '/usr/local/bin/fetch-content', 'task-artifacts']
attempt 1/5
Downloading https://taskcluster.bananium.fr/api/queue/v1/task/SkuoekyPQkmgt4oMEmWqSQ/artifacts/public/build/index.lock to /builds/worker/checkouts/vcs/index.lock
Downloading https://taskcluster.bananium.fr/api/queue/v1/task/SkuoekyPQkmgt4oMEmWqSQ/artifacts/public/build/index.lock
https://taskcluster.bananium.fr/api/queue/v1/task/SkuoekyPQkmgt4oMEmWqSQ/artifacts/public/build/index.lock resolved to 18818 bytes with sha256 953a2f9484e0e0d527cf00880408c25988460317b4c27dcfda194318c3533929 in 0.559s
PERFHERDER_DATA: {"framework": {"name": "build_metrics"}, "suites": [{"name": "fetch_content", "value": 0.5610905779758468, "lowerIsBetter": true, "shouldAlert": false, "subtests": []}]}
[fetches 2025-02-25T19:38:32.415Z] finished fetching artifacts
[task 2025-02-25T19:38:32.415Z] executing ['bash', '-cx', 'cd $VCS_PATH && apwm download -i ./ -d /tmp/download -p "${TEST_APWORLD_NAME}:${TEST_APWORLD_VERSION}" && cd /ap/archipelago && . .venv/bin/activate && unshare -r -n python3 -O /ap/archipelago/self_check.py /ap/supported_worlds /tmp/download "${TEST_APWORLD_NAME}" ${TEST_APWORLD_VERSION} "${TEST_WORLD_NAME}" /builds/worker/']
[task 2025-02-25T19:38:32.416Z] + cd /builds/worker/checkouts/vcs
[task 2025-02-25T19:38:32.416Z] + apwm download -i ./ -d /tmp/download -p megamix:1.1.9-beta-unofficial
[task 2025-02-25T19:38:33.166Z] + cd /ap/archipelago
[task 2025-02-25T19:38:33.167Z] + . .venv/bin/activate
[task 2025-02-25T19:38:33.167Z] ++ deactivate nondestructive
[task 2025-02-25T19:38:33.167Z] ++ '[' -n '' ']'
[task 2025-02-25T19:38:33.167Z] ++ '[' -n '' ']'
[task 2025-02-25T19:38:33.167Z] ++ '[' -n /usr/bin/bash -o -n '' ']'
[task 2025-02-25T19:38:33.167Z] ++ hash -r
[task 2025-02-25T19:38:33.168Z] ++ '[' -n '' ']'
[task 2025-02-25T19:38:33.168Z] ++ unset VIRTUAL_ENV
[task 2025-02-25T19:38:33.168Z] ++ unset VIRTUAL_ENV_PROMPT
[task 2025-02-25T19:38:33.168Z] ++ '[' '!' nondestructive = nondestructive ']'
[task 2025-02-25T19:38:33.168Z] ++ VIRTUAL_ENV=/ap/archipelago/.venv
[task 2025-02-25T19:38:33.168Z] ++ export VIRTUAL_ENV
[task 2025-02-25T19:38:33.168Z] ++ _OLD_VIRTUAL_PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
[task 2025-02-25T19:38:33.168Z] ++ PATH=/ap/archipelago/.venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
[task 2025-02-25T19:38:33.168Z] ++ export PATH
[task 2025-02-25T19:38:33.168Z] ++ '[' -n '' ']'
[task 2025-02-25T19:38:33.168Z] ++ '[' -z '' ']'
[task 2025-02-25T19:38:33.168Z] ++ _OLD_VIRTUAL_PS1=
[task 2025-02-25T19:38:33.169Z] ++ PS1='(.venv) '
[task 2025-02-25T19:38:33.169Z] ++ export PS1
[task 2025-02-25T19:38:33.169Z] ++ VIRTUAL_ENV_PROMPT='(.venv) '
[task 2025-02-25T19:38:33.169Z] ++ export VIRTUAL_ENV_PROMPT
[task 2025-02-25T19:38:33.169Z] ++ '[' -n /usr/bin/bash -o -n '' ']'
[task 2025-02-25T19:38:33.169Z] ++ hash -r
[task 2025-02-25T19:38:33.169Z] + unshare -r -n python3 -O /ap/archipelago/self_check.py /ap/supported_worlds /tmp/download megamix 1.1.9-beta-unofficial 'Hatsune Miku Project Diva Mega Mix+' /builds/worker/
[task 2025-02-25T19:38:34.523Z] /ap/archipelago/NetUtils.py:429: UserWarning: _speedups not available. Falling back to pure python LocationStore. Install a matching C++ compiler for your platform to compile _speedups.
[task 2025-02-25T19:38:34.524Z]   warnings.warn("_speedups not available. Falling back to pure python LocationStore. "
[task 2025-02-25T19:38:34.852Z] DEBUG:worlds.megamix.DataHandler:Checking YAMLs for megamix_mod_data at /builds/worker/
[task 2025-02-25T19:38:34.852Z] DEBUG:worlds.megamix.DataHandler:Found 0 songs
[task 2025-02-25T19:38:34.864Z] 1~10* [0, 1, 2, 3, 4] 179
[task 2025-02-25T19:38:34.864Z] Successfully validated megamix 1.1.9-beta-unofficial
+ exit_code=0
+ docker cp taskcontainer_ZKq0EPWTSTmgy0oMHl9KNw:/builds/worker/template.yaml artifact0.yaml
+ docker rm -v taskcontainer_ZKq0EPWTSTmgy0oMHl9KNw
taskcontainer_ZKq0EPWTSTmgy0oMHl9KNw
+ exit 0
[taskcluster 2025-02-25T19:38:35.184Z]    Exit Code: 0
[taskcluster 2025-02-25T19:38:35.184Z]    User Time: 19.451ms
[taskcluster 2025-02-25T19:38:35.184Z]  Kernel Time: 7.671ms
[taskcluster 2025-02-25T19:38:35.184Z]    Wall Time: 4.712163021s
[taskcluster 2025-02-25T19:38:35.184Z]       Result: SUCCEEDED
[taskcluster 2025-02-25T19:38:35.184Z] === Task Finished ===
[taskcluster 2025-02-25T19:38:35.184Z] Task Duration: 4.712401924s
[taskcluster 2025-02-25T19:38:35.255Z] Uploading artifact public/template.yaml from file /home/task_174051091372409/artifact0.yaml with content encoding "gzip", mime type "application/octet-stream" and expiry 2026-02-25T19:38:22.639Z
[taskcluster 2025-02-25T19:38:35.423Z] [mounts] Preserving cache: Moving "/home/task_174051091372409/cache0" to "caches/JXA3Er8KQL-jH913U0psFQ"
[taskcluster 2025-02-25T19:38:35.505Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2026-02-25T19:38:22.639Z