builder: release-maple-firefox-win32_partner_repacks slave: bld-lion-r5-043 starttime: 1519647721.1 results: failure (2) revision: 424acf519ab25caaad3e297b7fc4fac3a8aa000a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:01.103199) ========= master: http://buildbot-master82.bb.releng.scl3.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:01.103830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:01.104117) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:01.773679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:01.773995) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/rel-map-fx-w32_pner_rpks-00000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: Apple_PubSub_Socket_Render=/tmp/launch-Dq9KPb/Render DISPLAY=/tmp/launch-4kd0ln/org.x:0 GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/rel-map-fx-w32_pner_rpks-00000 RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/tmp/launch-r5QT6c/Listeners TMPDIR=/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2018-02-26 04:22:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.3M=0s 2018-02-26 04:22:02 (26.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.223053 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:02.049799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:02.050144) ========= rm -rf scripts properties in dir /builds/slave/rel-map-fx-w32_pner_rpks-00000/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/tmp/launch-Dq9KPb/Render DISPLAY=/tmp/launch-4kd0ln/org.x:0 GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/rel-map-fx-w32_pner_rpks-00000 RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/tmp/launch-r5QT6c/Listeners TMPDIR=/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.329276 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:02.394232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2018-02-26 04:22:02.394726) ========= bash -c 'python archiver_client.py mozharness --repo projects/maple --rev 424acf519ab25caaad3e297b7fc4fac3a8aa000a --destination scripts --debug' in dir /builds/slave/rel-map-fx-w32_pner_rpks-00000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/maple --rev 424acf519ab25caaad3e297b7fc4fac3a8aa000a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/tmp/launch-Dq9KPb/Render DISPLAY=/tmp/launch-4kd0ln/org.x:0 GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/rel-map-fx-w32_pner_rpks-00000 RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/tmp/launch-r5QT6c/Listeners TMPDIR=/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2018-02-26 04:22:02,692 truncating revision to first 12 chars 2018-02-26 04:22:02,692 Setting DEBUG logging. 2018-02-26 04:22:02,692 attempt 1/10 2018-02-26 04:22:02,692 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/maple/424acf519ab2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2018-02-26 04:22:03,297 attempt 1/10 2018-02-26 04:22:04,139 current task status: no status available at this point. state: STARTED 2018-02-26 04:22:04,140 sleeping for 11.00s (attempt 1/10) 2018-02-26 04:22:15,141 attempt 2/10 2018-02-26 04:22:15,577 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2018-02-26 04:22:15,936 unpacking tar archive at: maple-424acf519ab2/testing/mozharness/ program finished with exit code 0 elapsedTime=13.835681 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2018-02-26 04:22:16.244102) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:16.244488) ========= script_repo_revision: 424acf519ab25caaad3e297b7fc4fac3a8aa000a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:16.244910) ========= ========= Started remove old nonce (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:16.245229) ========= rm -f nonce in dir /builds/slave/rel-map-fx-w32_pner_rpks-00000/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'nonce'] environment: Apple_PubSub_Socket_Render=/tmp/launch-Dq9KPb/Render DISPLAY=/tmp/launch-4kd0ln/org.x:0 GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/rel-map-fx-w32_pner_rpks-00000 RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/tmp/launch-r5QT6c/Listeners TMPDIR=/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.006472 ========= master_lag: 0.05 ========= ========= Finished remove old nonce (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:16.297704) ========= ========= Started downloading to token (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:16.298013) ========= Slave: bld-lion-r5-043 IP: 10.26.52.63 Duration: 25200 URI: https://signing5.srv.releng.scl3.mozilla.com:9120/token ========= Finished downloading to token (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:16.328718) ========= ========= Started set props: toolsdir (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:16.329171) ========= bash -c pwd in dir /tools/checkouts/build-tools (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/tmp/launch-Dq9KPb/Render DISPLAY=/tmp/launch-4kd0ln/org.x:0 GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/tools/checkouts/build-tools RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/tmp/launch-r5QT6c/Listeners TMPDIR=/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /tools/checkouts/build-tools program finished with exit code 0 elapsedTime=0.005253 toolsdir: '/tools/checkouts/build-tools' ========= master_lag: 0.05 ========= ========= Finished set props: toolsdir (results: 0, elapsed: 0 secs) (at 2018-02-26 04:22:16.380414) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/desktop_partner_repacks.py ...' failed (results: 2, elapsed: 1 mins, 40 secs) (at 2018-02-26 04:22:16.380727) ========= /tools/buildbot/bin/python scripts/scripts/desktop_partner_repacks.py --cfg partner_repacks/release_mozilla-release_desktop.py --s3cfg NO_UPLOADS_IN_STAGING --platform win32 --hgrepo projects/maple in dir /builds/slave/rel-map-fx-w32_pner_rpks-00000/. (timeout 3600 secs) (maxTime 21600 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/desktop_partner_repacks.py', '--cfg', 'partner_repacks/release_mozilla-release_desktop.py', '--s3cfg', 'NO_UPLOADS_IN_STAGING', '--platform', 'win32', '--hgrepo', 'projects/maple'] environment: Apple_PubSub_Socket_Render=/tmp/launch-Dq9KPb/Render CCACHE_COMPRESS=1 CCACHE_DIR=/builds/ccache CCACHE_UMASK=002 CHOWN_REVERT=~/bin/chown_revert CHOWN_ROOT=~/bin/chown_root DISPLAY=/tmp/launch-4kd0ln/org.x:0 GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LC_ALL=C LOGNAME=cltbld MOZ_AUTOMATION=1 MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_OBJDIR=obj-firefox MOZ_SIGNING_SERVERS=gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120 MOZ_SIGN_CMD=python /tools/checkouts/build-tools/release/signing/signtool.py --cachedir /builds/slave/rel-map-fx-w32_pner_rpks-00000/signing_cache -t /builds/slave/rel-map-fx-w32_pner_rpks-00000/token -n /builds/slave/rel-map-fx-w32_pner_rpks-00000/nonce -c /tools/checkouts/build-tools/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120 PATH=/tools/python/bin:/tools/buildbot/bin:/opt/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/X11/bin PROPERTIES_FILE=/builds/slave/rel-map-fx-w32_pner_rpks-00000/buildprops.json PWD=/builds/slave/rel-map-fx-w32_pner_rpks-00000 RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/tmp/launch-r5QT6c/Listeners TINDERBOX_OUTPUT=1 TMPDIR=/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/ TOOLTOOL_CACHE=/builds/tooltool_cache TOOLTOOL_HOME=/builds TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:22:16 INFO - MultiFileLogger online at 20180226 04:22:16 in /builds/slave/rel-map-fx-w32_pner_rpks-00000 04:22:16 INFO - Using buildbot properties: 04:22:16 INFO - { 04:22:16 INFO - "project": "", 04:22:16 INFO - "product": "firefox", 04:22:16 INFO - "build_number": 5, 04:22:16 INFO - "taskId": "FlMEX0zlQRO9K3g6nPyH7A", 04:22:16 INFO - "repository": "https://hg.mozilla.org/projects/maple", 04:22:16 INFO - "buildername": "release-maple-firefox-win32_partner_repacks", 04:22:16 INFO - "balrog_api_root": "https://balrog-admin.stage.mozaws.net/api", 04:22:16 INFO - "basedir": "/builds/slave/rel-map-fx-w32_pner_rpks-00000", 04:22:16 INFO - "appVersion": "59.0", 04:22:16 INFO - "buildnumber": 42, 04:22:16 INFO - "platform": "macosx64", 04:22:16 INFO - "version": "59.0b13", 04:22:16 INFO - "release_promotion": true, 04:22:16 INFO - "repack_manifests_url": "git@github.com:mozilla-releng/staging-repack-manifests.git", 04:22:16 INFO - "branch": "maple", 04:22:16 INFO - "script_repo_revision": "424acf519ab25caaad3e297b7fc4fac3a8aa000a", 04:22:16 INFO - "master": "http://buildbot-master82.bb.releng.scl3.mozilla.com:8001/", 04:22:16 INFO - "revision": "424acf519ab25caaad3e297b7fc4fac3a8aa000a", 04:22:16 INFO - "slavename": "bld-lion-r5-043", 04:22:16 INFO - "next_version": "59.0b14", 04:22:16 INFO - "repo_path": "projects/maple" 04:22:16 INFO - } 04:22:16 INFO - Overriding version with 59.0b13 04:22:16 INFO - Overriding build_number with 5 04:22:16 INFO - Overriding revision with 424acf519ab25caaad3e297b7fc4fac3a8aa000a 04:22:16 INFO - Overriding repack_manifests_url with git@github.com:mozilla-releng/staging-repack-manifests.git 04:22:16 INFO - Run as scripts/scripts/desktop_partner_repacks.py --cfg partner_repacks/release_mozilla-release_desktop.py --s3cfg NO_UPLOADS_IN_STAGING --platform win32 --hgrepo projects/maple 04:22:16 INFO - Dumping config to /builds/slave/rel-map-fx-w32_pner_rpks-00000/logs/localconfig.json. 04:22:16 INFO - {'appName': 'Firefox', 04:22:16 INFO - 'append_to_log': False, 04:22:16 INFO - 'base_work_dir': '/builds/slave/rel-map-fx-w32_pner_rpks-00000', 04:22:16 INFO - 'build_number': 5, 04:22:16 INFO - 'buildbot_json_path': 'buildprops.json', 04:22:16 INFO - 'config_files': ('partner_repacks/release_mozilla-release_desktop.py',), 04:22:16 INFO - 'hashType': 'sha512', 04:22:16 INFO - 'hgrepo': 'projects/maple', 04:22:16 INFO - 'log_level': 'info', 04:22:16 INFO - 'log_name': 'partner_repack', 04:22:16 INFO - 'log_to_console': True, 04:22:16 INFO - 'opt_config_files': (), 04:22:16 INFO - 'platform': 'win32', 04:22:16 INFO - 'repack_manifests_url': 'git@github.com:mozilla-releng/staging-repack-manifests.git', 04:22:16 INFO - 'repo_file': 'https://raw.githubusercontent.com/mozilla/git-repo/master/repo', 04:22:16 INFO - 'require_buildprops': False, 04:22:16 INFO - 'revision': '424acf519ab25caaad3e297b7fc4fac3a8aa000a', 04:22:16 INFO - 's3cfg': 'NO_UPLOADS_IN_STAGING', 04:22:16 INFO - 'version': '59.0b13', 04:22:16 INFO - 'virtualenv_modules': ('requests==2.2.1', 04:22:16 INFO - 'PyHawk-with-a-single-extra-commit==0.1.5', 04:22:16 INFO - 'taskcluster==0.0.15', 04:22:16 INFO - 's3cmd==1.6.0'), 04:22:16 INFO - 'virtualenv_path': 'venv', 04:22:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:22:16 INFO - 'work_dir': 'build', 04:22:16 INFO - 'workdir': 'partner-repacks'} 04:22:16 INFO - [mozharness: 2018-02-26 12:22:16.710047Z] Running clobber step. 04:22:16 INFO - Running main action method: clobber 04:22:16 INFO - rmtree: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build 04:22:16 INFO - retry: Calling rmtree with args: ('/builds/slave/rel-map-fx-w32_pner_rpks-00000/build',), kwargs: {}, attempt #1 04:22:17 INFO - [mozharness: 2018-02-26 12:22:17.718171Z] Finished clobber step (success) 04:22:17 INFO - [mozharness: 2018-02-26 12:22:17.718437Z] Running create-virtualenv step. 04:22:17 INFO - Running main action method: create_virtualenv 04:22:17 INFO - Creating virtualenv /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv 04:22:17 INFO - mkdir: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build 04:22:17 INFO - Running command: ['/tools/buildbot/bin/python', '/builds/slave/rel-map-fx-w32_pner_rpks-00000/scripts/external_tools/virtualenv/virtualenv.py', '--always-copy', '/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv'] in /builds/slave/rel-map-fx-w32_pner_rpks-00000/build 04:22:17 INFO - Copy/paste: /tools/buildbot/bin/python /builds/slave/rel-map-fx-w32_pner_rpks-00000/scripts/external_tools/virtualenv/virtualenv.py --always-copy /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv 04:22:17 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:22:19 INFO - Using real prefix '/tools/python27' 04:22:19 INFO - New python executable in /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/python 04:22:19 INFO - Overwriting /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/lib/python2.7/distutils/__init__.py with new content 04:22:22 INFO - Installing setuptools, pip, wheel...done. 04:22:22 INFO - Return code: 0 04:22:22 INFO - Installing requests==2.2.1 into virtualenv /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv 04:22:22 INFO - retry: Calling run_command with args: [['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip', 'install', '--timeout', '120', 'requests==2.2.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101123e40>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101402470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c1d00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10063cda0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c7d98>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/build', 'env': {'CHOWN_ROOT': '~/bin/chown_root', 'MOZ_AUTOMATION': '1', 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'MOZ_OBJDIR': 'obj-firefox', 'PATH': '/tools/python/bin:/tools/buildbot/bin:/opt/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/X11/bin', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'CCACHE_UMASK': '002', 'Apple_PubSub_Socket_Render': '/tmp/launch-Dq9KPb/Render', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'DISPLAY': '/tmp/launch-4kd0ln/org.x:0', 'HOME': '/Users/cltbld', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'CCACHE_DIR': '/builds/ccache', 'SSH_AUTH_SOCK': '/tmp/launch-r5QT6c/Listeners', 'SHELL': '/bin/bash', 'MOZ_SIGN_CMD': 'python /tools/checkouts/build-tools/release/signing/signtool.py --cachedir /builds/slave/rel-map-fx-w32_pner_rpks-00000/signing_cache -t /builds/slave/rel-map-fx-w32_pner_rpks-00000/token -n /builds/slave/rel-map-fx-w32_pner_rpks-00000/nonce -c /tools/checkouts/build-tools/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 'LC_ALL': 'C', 'TOOLTOOL_HOME': '/builds', 'CHOWN_REVERT': '~/bin/chown_revert', 'TMPDIR': '/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/rel-map-fx-w32_pner_rpks-00000', 'TINDERBOX_OUTPUT': '1', 'PROPERTIES_FILE': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'CCACHE_COMPRESS': '1', 'TOOLTOOL_CACHE': '/builds/tooltool_cache'}}, attempt #1 04:22:22 INFO - Running command: ['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip', 'install', '--timeout', '120', 'requests==2.2.1'] in /builds/slave/rel-map-fx-w32_pner_rpks-00000/build 04:22:22 INFO - Copy/paste: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip install --timeout 120 requests==2.2.1 04:22:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/tmp/launch-Dq9KPb/Render', 04:22:22 INFO - 'CCACHE_COMPRESS': '1', 04:22:22 INFO - 'CCACHE_DIR': '/builds/ccache', 04:22:22 INFO - 'CCACHE_UMASK': '002', 04:22:22 INFO - 'CHOWN_REVERT': '~/bin/chown_revert', 04:22:22 INFO - 'CHOWN_ROOT': '~/bin/chown_root', 04:22:22 INFO - 'DISPLAY': '/tmp/launch-4kd0ln/org.x:0', 04:22:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:22 INFO - 'HOME': '/Users/cltbld', 04:22:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:22 INFO - 'LC_ALL': 'C', 04:22:22 INFO - 'LOGNAME': 'cltbld', 04:22:22 INFO - 'MOZ_AUTOMATION': '1', 04:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:22 INFO - 'MOZ_OBJDIR': 'obj-firefox', 04:22:22 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 04:22:22 INFO - 'MOZ_SIGN_CMD': 'python /tools/checkouts/build-tools/release/signing/signtool.py --cachedir /builds/slave/rel-map-fx-w32_pner_rpks-00000/signing_cache -t /builds/slave/rel-map-fx-w32_pner_rpks-00000/token -n /builds/slave/rel-map-fx-w32_pner_rpks-00000/nonce -c /tools/checkouts/build-tools/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 04:22:22 INFO - 'PATH': '/tools/python/bin:/tools/buildbot/bin:/opt/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/X11/bin', 04:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/buildprops.json', 04:22:22 INFO - 'PWD': '/builds/slave/rel-map-fx-w32_pner_rpks-00000', 04:22:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:22 INFO - 'SHELL': '/bin/bash', 04:22:22 INFO - 'SSH_AUTH_SOCK': '/tmp/launch-r5QT6c/Listeners', 04:22:22 INFO - 'TINDERBOX_OUTPUT': '1', 04:22:22 INFO - 'TMPDIR': '/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/', 04:22:22 INFO - 'TOOLTOOL_CACHE': '/builds/tooltool_cache', 04:22:22 INFO - 'TOOLTOOL_HOME': '/builds', 04:22:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:22 INFO - 'USER': 'cltbld', 04:22:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple 04:22:22 INFO - Collecting requests==2.2.1 04:22:24 INFO - Installing collected packages: requests 04:22:24 INFO - Successfully installed requests-2.2.1 04:22:24 INFO - Return code: 0 04:22:24 INFO - Installing PyHawk-with-a-single-extra-commit==0.1.5 into virtualenv /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv 04:22:24 INFO - retry: Calling run_command with args: [['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip', 'install', '--timeout', '120', 'PyHawk-with-a-single-extra-commit==0.1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101123e40>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101402470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c1d00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10063cda0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c7d98>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/build', 'env': {'CHOWN_ROOT': '~/bin/chown_root', 'MOZ_AUTOMATION': '1', 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'MOZ_OBJDIR': 'obj-firefox', 'PATH': '/tools/python/bin:/tools/buildbot/bin:/opt/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/X11/bin', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'CCACHE_UMASK': '002', 'Apple_PubSub_Socket_Render': '/tmp/launch-Dq9KPb/Render', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'DISPLAY': '/tmp/launch-4kd0ln/org.x:0', 'HOME': '/Users/cltbld', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'CCACHE_DIR': '/builds/ccache', 'SSH_AUTH_SOCK': '/tmp/launch-r5QT6c/Listeners', 'SHELL': '/bin/bash', 'MOZ_SIGN_CMD': 'python /tools/checkouts/build-tools/release/signing/signtool.py --cachedir /builds/slave/rel-map-fx-w32_pner_rpks-00000/signing_cache -t /builds/slave/rel-map-fx-w32_pner_rpks-00000/token -n /builds/slave/rel-map-fx-w32_pner_rpks-00000/nonce -c /tools/checkouts/build-tools/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 'LC_ALL': 'C', 'TOOLTOOL_HOME': '/builds', 'CHOWN_REVERT': '~/bin/chown_revert', 'TMPDIR': '/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/rel-map-fx-w32_pner_rpks-00000', 'TINDERBOX_OUTPUT': '1', 'PROPERTIES_FILE': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'CCACHE_COMPRESS': '1', 'TOOLTOOL_CACHE': '/builds/tooltool_cache'}}, attempt #1 04:22:24 INFO - Running command: ['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip', 'install', '--timeout', '120', 'PyHawk-with-a-single-extra-commit==0.1.5'] in /builds/slave/rel-map-fx-w32_pner_rpks-00000/build 04:22:24 INFO - Copy/paste: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip install --timeout 120 PyHawk-with-a-single-extra-commit==0.1.5 04:22:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/tmp/launch-Dq9KPb/Render', 04:22:24 INFO - 'CCACHE_COMPRESS': '1', 04:22:24 INFO - 'CCACHE_DIR': '/builds/ccache', 04:22:24 INFO - 'CCACHE_UMASK': '002', 04:22:24 INFO - 'CHOWN_REVERT': '~/bin/chown_revert', 04:22:24 INFO - 'CHOWN_ROOT': '~/bin/chown_root', 04:22:24 INFO - 'DISPLAY': '/tmp/launch-4kd0ln/org.x:0', 04:22:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:24 INFO - 'HOME': '/Users/cltbld', 04:22:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:24 INFO - 'LC_ALL': 'C', 04:22:24 INFO - 'LOGNAME': 'cltbld', 04:22:24 INFO - 'MOZ_AUTOMATION': '1', 04:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:24 INFO - 'MOZ_OBJDIR': 'obj-firefox', 04:22:24 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 04:22:24 INFO - 'MOZ_SIGN_CMD': 'python /tools/checkouts/build-tools/release/signing/signtool.py --cachedir /builds/slave/rel-map-fx-w32_pner_rpks-00000/signing_cache -t /builds/slave/rel-map-fx-w32_pner_rpks-00000/token -n /builds/slave/rel-map-fx-w32_pner_rpks-00000/nonce -c /tools/checkouts/build-tools/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 04:22:24 INFO - 'PATH': '/tools/python/bin:/tools/buildbot/bin:/opt/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/X11/bin', 04:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/buildprops.json', 04:22:24 INFO - 'PWD': '/builds/slave/rel-map-fx-w32_pner_rpks-00000', 04:22:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:24 INFO - 'SHELL': '/bin/bash', 04:22:24 INFO - 'SSH_AUTH_SOCK': '/tmp/launch-r5QT6c/Listeners', 04:22:24 INFO - 'TINDERBOX_OUTPUT': '1', 04:22:24 INFO - 'TMPDIR': '/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/', 04:22:24 INFO - 'TOOLTOOL_CACHE': '/builds/tooltool_cache', 04:22:24 INFO - 'TOOLTOOL_HOME': '/builds', 04:22:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:24 INFO - 'USER': 'cltbld', 04:22:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple 04:22:25 INFO - Collecting PyHawk-with-a-single-extra-commit==0.1.5 04:22:26 INFO - Installing collected packages: PyHawk-with-a-single-extra-commit 04:22:26 INFO - Successfully installed PyHawk-with-a-single-extra-commit-0.1.5 04:22:26 INFO - Return code: 0 04:22:26 INFO - Installing taskcluster==0.0.15 into virtualenv /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv 04:22:26 INFO - retry: Calling run_command with args: [['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip', 'install', '--timeout', '120', 'taskcluster==0.0.15']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101123e40>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101402470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c1d00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10063cda0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c7d98>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/build', 'env': {'CHOWN_ROOT': '~/bin/chown_root', 'MOZ_AUTOMATION': '1', 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'MOZ_OBJDIR': 'obj-firefox', 'PATH': '/tools/python/bin:/tools/buildbot/bin:/opt/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/X11/bin', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'CCACHE_UMASK': '002', 'Apple_PubSub_Socket_Render': '/tmp/launch-Dq9KPb/Render', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'DISPLAY': '/tmp/launch-4kd0ln/org.x:0', 'HOME': '/Users/cltbld', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'CCACHE_DIR': '/builds/ccache', 'SSH_AUTH_SOCK': '/tmp/launch-r5QT6c/Listeners', 'SHELL': '/bin/bash', 'MOZ_SIGN_CMD': 'python /tools/checkouts/build-tools/release/signing/signtool.py --cachedir /builds/slave/rel-map-fx-w32_pner_rpks-00000/signing_cache -t /builds/slave/rel-map-fx-w32_pner_rpks-00000/token -n /builds/slave/rel-map-fx-w32_pner_rpks-00000/nonce -c /tools/checkouts/build-tools/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 'LC_ALL': 'C', 'TOOLTOOL_HOME': '/builds', 'CHOWN_REVERT': '~/bin/chown_revert', 'TMPDIR': '/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/rel-map-fx-w32_pner_rpks-00000', 'TINDERBOX_OUTPUT': '1', 'PROPERTIES_FILE': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'CCACHE_COMPRESS': '1', 'TOOLTOOL_CACHE': '/builds/tooltool_cache'}}, attempt #1 04:22:26 INFO - Running command: ['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip', 'install', '--timeout', '120', 'taskcluster==0.0.15'] in /builds/slave/rel-map-fx-w32_pner_rpks-00000/build 04:22:26 INFO - Copy/paste: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip install --timeout 120 taskcluster==0.0.15 04:22:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/tmp/launch-Dq9KPb/Render', 04:22:26 INFO - 'CCACHE_COMPRESS': '1', 04:22:26 INFO - 'CCACHE_DIR': '/builds/ccache', 04:22:26 INFO - 'CCACHE_UMASK': '002', 04:22:26 INFO - 'CHOWN_REVERT': '~/bin/chown_revert', 04:22:26 INFO - 'CHOWN_ROOT': '~/bin/chown_root', 04:22:26 INFO - 'DISPLAY': '/tmp/launch-4kd0ln/org.x:0', 04:22:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:26 INFO - 'HOME': '/Users/cltbld', 04:22:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:26 INFO - 'LC_ALL': 'C', 04:22:26 INFO - 'LOGNAME': 'cltbld', 04:22:26 INFO - 'MOZ_AUTOMATION': '1', 04:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:26 INFO - 'MOZ_OBJDIR': 'obj-firefox', 04:22:26 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 04:22:26 INFO - 'MOZ_SIGN_CMD': 'python /tools/checkouts/build-tools/release/signing/signtool.py --cachedir /builds/slave/rel-map-fx-w32_pner_rpks-00000/signing_cache -t /builds/slave/rel-map-fx-w32_pner_rpks-00000/token -n /builds/slave/rel-map-fx-w32_pner_rpks-00000/nonce -c /tools/checkouts/build-tools/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 04:22:26 INFO - 'PATH': '/tools/python/bin:/tools/buildbot/bin:/opt/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/X11/bin', 04:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/buildprops.json', 04:22:26 INFO - 'PWD': '/builds/slave/rel-map-fx-w32_pner_rpks-00000', 04:22:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:26 INFO - 'SHELL': '/bin/bash', 04:22:26 INFO - 'SSH_AUTH_SOCK': '/tmp/launch-r5QT6c/Listeners', 04:22:26 INFO - 'TINDERBOX_OUTPUT': '1', 04:22:26 INFO - 'TMPDIR': '/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/', 04:22:26 INFO - 'TOOLTOOL_CACHE': '/builds/tooltool_cache', 04:22:26 INFO - 'TOOLTOOL_HOME': '/builds', 04:22:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:26 INFO - 'USER': 'cltbld', 04:22:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple 04:22:27 INFO - Collecting taskcluster==0.0.15 04:22:28 INFO - Collecting requests==2.4.3 (from taskcluster==0.0.15) 04:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): PyHawk-with-a-single-extra-commit==0.1.5 in ./venv/lib/python2.7/site-packages (from taskcluster==0.0.15) 04:22:30 INFO - Installing collected packages: requests, taskcluster 04:22:30 INFO - Found existing installation: requests 2.2.1 04:22:30 INFO - Uninstalling requests-2.2.1: 04:22:30 INFO - Successfully uninstalled requests-2.2.1 04:22:31 INFO - Successfully installed requests-2.4.3 taskcluster-0.0.15 04:22:31 INFO - Return code: 0 04:22:31 INFO - Installing s3cmd==1.6.0 into virtualenv /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv 04:22:31 INFO - retry: Calling run_command with args: [['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip', 'install', '--timeout', '120', 's3cmd==1.6.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101123e40>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101402470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006c1d00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10063cda0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c7d98>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/build', 'env': {'CHOWN_ROOT': '~/bin/chown_root', 'MOZ_AUTOMATION': '1', 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'MOZ_OBJDIR': 'obj-firefox', 'PATH': '/tools/python/bin:/tools/buildbot/bin:/opt/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/X11/bin', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'CCACHE_UMASK': '002', 'Apple_PubSub_Socket_Render': '/tmp/launch-Dq9KPb/Render', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'DISPLAY': '/tmp/launch-4kd0ln/org.x:0', 'HOME': '/Users/cltbld', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'CCACHE_DIR': '/builds/ccache', 'SSH_AUTH_SOCK': '/tmp/launch-r5QT6c/Listeners', 'SHELL': '/bin/bash', 'MOZ_SIGN_CMD': 'python /tools/checkouts/build-tools/release/signing/signtool.py --cachedir /builds/slave/rel-map-fx-w32_pner_rpks-00000/signing_cache -t /builds/slave/rel-map-fx-w32_pner_rpks-00000/token -n /builds/slave/rel-map-fx-w32_pner_rpks-00000/nonce -c /tools/checkouts/build-tools/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 'LC_ALL': 'C', 'TOOLTOOL_HOME': '/builds', 'CHOWN_REVERT': '~/bin/chown_revert', 'TMPDIR': '/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/rel-map-fx-w32_pner_rpks-00000', 'TINDERBOX_OUTPUT': '1', 'PROPERTIES_FILE': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'CCACHE_COMPRESS': '1', 'TOOLTOOL_CACHE': '/builds/tooltool_cache'}}, attempt #1 04:22:31 INFO - Running command: ['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip', 'install', '--timeout', '120', 's3cmd==1.6.0'] in /builds/slave/rel-map-fx-w32_pner_rpks-00000/build 04:22:31 INFO - Copy/paste: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip install --timeout 120 s3cmd==1.6.0 04:22:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/tmp/launch-Dq9KPb/Render', 04:22:31 INFO - 'CCACHE_COMPRESS': '1', 04:22:31 INFO - 'CCACHE_DIR': '/builds/ccache', 04:22:31 INFO - 'CCACHE_UMASK': '002', 04:22:31 INFO - 'CHOWN_REVERT': '~/bin/chown_revert', 04:22:31 INFO - 'CHOWN_ROOT': '~/bin/chown_root', 04:22:31 INFO - 'DISPLAY': '/tmp/launch-4kd0ln/org.x:0', 04:22:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:31 INFO - 'HOME': '/Users/cltbld', 04:22:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:31 INFO - 'LC_ALL': 'C', 04:22:31 INFO - 'LOGNAME': 'cltbld', 04:22:31 INFO - 'MOZ_AUTOMATION': '1', 04:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:31 INFO - 'MOZ_OBJDIR': 'obj-firefox', 04:22:31 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 04:22:31 INFO - 'MOZ_SIGN_CMD': 'python /tools/checkouts/build-tools/release/signing/signtool.py --cachedir /builds/slave/rel-map-fx-w32_pner_rpks-00000/signing_cache -t /builds/slave/rel-map-fx-w32_pner_rpks-00000/token -n /builds/slave/rel-map-fx-w32_pner_rpks-00000/nonce -c /tools/checkouts/build-tools/release/signing/host.cert -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:sha2signcodestub:osslsigncode:signcode:mar:mar_sha384:jar:emevoucher:widevine:widevine_blessed:signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H macapp:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 04:22:31 INFO - 'PATH': '/tools/python/bin:/tools/buildbot/bin:/opt/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/X11/bin', 04:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/buildprops.json', 04:22:31 INFO - 'PWD': '/builds/slave/rel-map-fx-w32_pner_rpks-00000', 04:22:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:31 INFO - 'SHELL': '/bin/bash', 04:22:31 INFO - 'SSH_AUTH_SOCK': '/tmp/launch-r5QT6c/Listeners', 04:22:31 INFO - 'TINDERBOX_OUTPUT': '1', 04:22:31 INFO - 'TMPDIR': '/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/', 04:22:31 INFO - 'TOOLTOOL_CACHE': '/builds/tooltool_cache', 04:22:31 INFO - 'TOOLTOOL_HOME': '/builds', 04:22:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:31 INFO - 'USER': 'cltbld', 04:22:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple 04:22:31 INFO - Collecting s3cmd==1.6.0 04:22:33 INFO - Collecting python-dateutil (from s3cmd==1.6.0) 04:22:35 INFO - Collecting python-magic (from s3cmd==1.6.0) 04:22:36 INFO - Collecting six>=1.5 (from python-dateutil->s3cmd==1.6.0) 04:22:38 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/six-1.10.0-py2.py3-none-any.whl 04:22:38 INFO - Installing collected packages: six, python-dateutil, python-magic, s3cmd 04:22:38 INFO - Successfully installed python-dateutil-2.6.0 python-magic-0.4.6 s3cmd-1.6.0 six-1.10.0 04:22:38 INFO - Return code: 0 04:22:38 INFO - Done creating virtualenv /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv. 04:22:38 INFO - Getting output from command: ['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip', 'freeze'] 04:22:38 INFO - Copy/paste: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/venv/bin/pip freeze 04:22:39 INFO - Reading from file tmpfile_stdout 04:22:39 INFO - Reading from file tmpfile_stderr 04:22:39 INFO - Current package versions: 04:22:39 INFO - PyHawk-with-a-single-extra-commit == 0.1.5 04:22:39 INFO - python-dateutil == 2.6.0 04:22:39 INFO - python-magic == 0.4.6 04:22:39 INFO - requests == 2.4.3 04:22:39 INFO - s3cmd == 1.6.0 04:22:39 INFO - six == 1.10.0 04:22:39 INFO - taskcluster == 0.0.15 04:22:39 INFO - [mozharness: 2018-02-26 12:22:39.571697Z] Finished create-virtualenv step (success) 04:22:39 INFO - [mozharness: 2018-02-26 12:22:39.571934Z] Running activate-virtualenv step. 04:22:39 INFO - Running main action method: activate_virtualenv 04:22:39 INFO - [mozharness: 2018-02-26 12:22:39.573844Z] Finished activate-virtualenv step (success) 04:22:39 INFO - [mozharness: 2018-02-26 12:22:39.574065Z] Running setup step. 04:22:39 INFO - Running main action method: setup 04:22:39 INFO - Downloading https://raw.githubusercontent.com/mozilla/git-repo/master/repo to /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo 04:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://raw.githubusercontent.com/mozilla/git-repo/master/repo', 'file_name': '/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo'}, attempt #1 04:22:39 INFO - Downloaded 24007 bytes. 04:22:39 INFO - Chmoding /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo to 0755 04:22:39 INFO - rmtree: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/.repo 04:22:39 INFO - rmtree: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/partners 04:22:39 INFO - rmtree: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/scripts 04:22:39 INFO - retry: Calling _repo_init with args: ('/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo',), kwargs: {}, attempt #1 04:22:39 INFO - Running command: ['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo', 'init', '--no-repo-verify', '-u', 'git@github.com:mozilla-releng/staging-repack-manifests.git'] in /builds/slave/rel-map-fx-w32_pner_rpks-00000/build 04:22:39 INFO - Copy/paste: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo init --no-repo-verify -u git@github.com:mozilla-releng/staging-repack-manifests.git 04:22:39 INFO - warning: gpg (GnuPG) is not available. 04:22:39 INFO - warning: Installing it is strongly encouraged. 04:22:40 INFO - fatal: Cannot get https://github.com/mozilla/git-repo/clone.bundle 04:22:40 INFO - fatal: error [SSL: TLSV1_ALERT_PROTOCOL_VERSION] tlsv1 alert protocol version (_ssl.c:590) 04:22:40 ERROR - Return code: 1 04:22:40 INFO - retry: Failed, sleeping 5 seconds before retrying 04:22:45 INFO - retry: Calling _repo_init with args: ('/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo',), kwargs: {}, attempt #2 04:22:45 INFO - Running command: ['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo', 'init', '--no-repo-verify', '-u', 'git@github.com:mozilla-releng/staging-repack-manifests.git'] in /builds/slave/rel-map-fx-w32_pner_rpks-00000/build 04:22:45 INFO - Copy/paste: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo init --no-repo-verify -u git@github.com:mozilla-releng/staging-repack-manifests.git 04:22:45 INFO - warning: gpg (GnuPG) is not available. 04:22:45 INFO - warning: Installing it is strongly encouraged. 04:22:45 INFO - fatal: Cannot get https://github.com/mozilla/git-repo/clone.bundle 04:22:45 INFO - fatal: error [SSL: TLSV1_ALERT_PROTOCOL_VERSION] tlsv1 alert protocol version (_ssl.c:590) 04:22:45 ERROR - Return code: 1 04:22:45 INFO - retry: Failed, sleeping 10 seconds before retrying 04:22:55 INFO - retry: Calling _repo_init with args: ('/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo',), kwargs: {}, attempt #3 04:22:55 INFO - Running command: ['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo', 'init', '--no-repo-verify', '-u', 'git@github.com:mozilla-releng/staging-repack-manifests.git'] in /builds/slave/rel-map-fx-w32_pner_rpks-00000/build 04:22:55 INFO - Copy/paste: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo init --no-repo-verify -u git@github.com:mozilla-releng/staging-repack-manifests.git 04:22:55 INFO - warning: gpg (GnuPG) is not available. 04:22:55 INFO - warning: Installing it is strongly encouraged. 04:22:55 INFO - fatal: Cannot get https://github.com/mozilla/git-repo/clone.bundle 04:22:55 INFO - fatal: error [SSL: TLSV1_ALERT_PROTOCOL_VERSION] tlsv1 alert protocol version (_ssl.c:590) 04:22:55 ERROR - Return code: 1 04:22:55 INFO - retry: Failed, sleeping 20 seconds before retrying 04:23:15 INFO - retry: Calling _repo_init with args: ('/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo',), kwargs: {}, attempt #4 04:23:15 INFO - Running command: ['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo', 'init', '--no-repo-verify', '-u', 'git@github.com:mozilla-releng/staging-repack-manifests.git'] in /builds/slave/rel-map-fx-w32_pner_rpks-00000/build 04:23:15 INFO - Copy/paste: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo init --no-repo-verify -u git@github.com:mozilla-releng/staging-repack-manifests.git 04:23:15 INFO - warning: gpg (GnuPG) is not available. 04:23:15 INFO - warning: Installing it is strongly encouraged. 04:23:15 INFO - fatal: Cannot get https://github.com/mozilla/git-repo/clone.bundle 04:23:15 INFO - fatal: error [SSL: TLSV1_ALERT_PROTOCOL_VERSION] tlsv1 alert protocol version (_ssl.c:590) 04:23:15 ERROR - Return code: 1 04:23:15 INFO - retry: Failed, sleeping 40 seconds before retrying 04:23:55 INFO - retry: Calling _repo_init with args: ('/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo',), kwargs: {}, attempt #5 04:23:55 INFO - Running command: ['/builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo', 'init', '--no-repo-verify', '-u', 'git@github.com:mozilla-releng/staging-repack-manifests.git'] in /builds/slave/rel-map-fx-w32_pner_rpks-00000/build 04:23:55 INFO - Copy/paste: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/repo init --no-repo-verify -u git@github.com:mozilla-releng/staging-repack-manifests.git 04:23:55 INFO - warning: gpg (GnuPG) is not available. 04:23:55 INFO - warning: Installing it is strongly encouraged. 04:23:57 INFO - fatal: Cannot get https://github.com/mozilla/git-repo/clone.bundle 04:23:57 INFO - fatal: error [SSL: TLSV1_ALERT_PROTOCOL_VERSION] tlsv1 alert protocol version (_ssl.c:590) 04:23:57 ERROR - Return code: 1 04:23:57 FATAL - > failed after 5 tries! 04:23:57 FATAL - Running post_fatal callback... 04:23:57 FATAL - Exiting -1 04:23:57 INFO - [mozharness: 2018-02-26 12:23:57.037622Z] Finished setup step (failed) 04:23:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:23:57 INFO - Copying logs to upload dir... 04:23:57 INFO - mkdir: /builds/slave/rel-map-fx-w32_pner_rpks-00000/build/upload/logs program finished with exit code 255 elapsedTime=100.665469 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/desktop_partner_repacks.py ...' failed (results: 2, elapsed: 1 mins, 40 secs) (at 2018-02-26 04:23:57.071446) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2018-02-26 04:23:57.074117) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-map-fx-w32_pner_rpks-00000/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/tmp/launch-Dq9KPb/Render DISPLAY=/tmp/launch-4kd0ln/org.x:0 GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/rel-map-fx-w32_pner_rpks-00000/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/tmp/launch-r5QT6c/Listeners TMPDIR=/var/folders/77/lwv0g1vx6wq555jq2ylgvnw000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.041799 ========= master_lag: 0.03 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2018-02-26 04:23:57.146584) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2018-02-26 04:23:57.146892) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2018-02-26 04:23:57.147383) ========= ========= Total master_lag: 0.23 =========