builder: mozilla-aurora_yosemite_r7_test-other-e10s
slave: t-yosemite-r7-0077
starttime: 1483957354.82
results: failure (2)
buildid: 20170108234108
builduid: 61c8c2b722174db491f223ed4bcb537d
revision: fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 02:22:34.822846) =========
master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 02:22:34.823309) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 20 secs) (at 2017-01-09 02:22:34.823906) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 20 secs) (at 2017-01-09 02:22:54.894710) =========

========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2017-01-09 02:22:54.895275) =========
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/test/. (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=/private/tmp/com.apple.launchd.YFWwinauDy/Render
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_NO_REMOTE=1
  NO_EM_RESTART=1
  PAGER=/bin/cat
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/test
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ye2gxLXUIU/Listeners
  TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  XPCOM_DEBUG_BREAK=warn
  XPC_FLAGS=0x0
  XPC_SERVICE_NAME=0
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
--2017-01-09 02:22:55--  https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: 'archiver_client.py'

     0K .......... .                                          100%  171M=0s

2017-01-09 02:22:56 (171 MB/s) - 'archiver_client.py' saved [12179/12179]

program finished with exit code 0
elapsedTime=1.692652
========= master_lag: 6.97 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2017-01-09 02:23:03.558802) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2017-01-09 02:23:03.559143) =========
rm -rf scripts properties
 in dir /builds/slave/test/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'scripts', 'properties']
 environment:
  Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YFWwinauDy/Render
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_NO_REMOTE=1
  NO_EM_RESTART=1
  PAGER=/bin/cat
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/test
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ye2gxLXUIU/Listeners
  TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  XPCOM_DEBUG_BREAK=warn
  XPC_FLAGS=0x0
  XPC_SERVICE_NAME=0
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
program finished with exit code 0
elapsedTime=0.030258
========= master_lag: 3.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2017-01-09 02:23:06.627928) =========

========= Started 'bash -c ...' (results: 0, elapsed: 19 secs) (at 2017-01-09 02:23:06.628273) =========
bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 --destination scripts --debug'
 in dir /builds/slave/test/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 --destination scripts --debug']
 environment:
  Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YFWwinauDy/Render
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_NO_REMOTE=1
  NO_EM_RESTART=1
  PAGER=/bin/cat
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/test
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ye2gxLXUIU/Listeners
  TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  XPCOM_DEBUG_BREAK=warn
  XPC_FLAGS=0x0
  XPC_SERVICE_NAME=0
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
2017-01-09 02:23:10,808 truncating revision to first 12 chars
2017-01-09 02:23:10,808 Setting DEBUG logging.
2017-01-09 02:23:10,808 attempt 1/10
2017-01-09 02:23:10,808 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fed81ec38bdf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-01-09 02:23:14,400 unpacking tar archive at: mozilla-aurora-fed81ec38bdf/testing/mozharness/
program finished with exit code 0
elapsedTime=3.863337
========= master_lag: 16.13 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 19 secs) (at 2017-01-09 02:23:26.625792) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 02:23:26.626114) =========
script_repo_revision: fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 02:23:26.626500) =========

========= Started downloading to oauth.txt (results: 0, elapsed: 18 secs) (at 2017-01-09 02:23:26.626778) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 18 secs) (at 2017-01-09 02:23:45.260851) =========

========= Started '/tools/buildbot/bin/python -u ...' failed (results: 2, elapsed: 3 mins, 48 secs) (at 2017-01-09 02:23:45.261272) =========
/tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite other-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora
 in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs)
 watching logfiles {}
 argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'other-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora']
 environment:
  Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YFWwinauDy/Render
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_NO_REMOTE=1
  NO_EM_RESTART=1
  PAGER=/bin/cat
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PROPERTIES_FILE=/builds/slave/test/buildprops.json
  PWD=/builds/slave/test
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ye2gxLXUIU/Listeners
  TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  XPCOM_DEBUG_BREAK=warn
  XPC_FLAGS=0x0
  XPC_SERVICE_NAME=0
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
02:23:45     INFO - MultiFileLogger online at 20170109 02:23:45 in /builds/slave/test
02:23:45     INFO - Run as scripts/scripts/talos_script.py --suite other-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora
02:23:45     INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
02:23:45     INFO - {'append_to_log': False,
02:23:45     INFO -  'base_work_dir': '/builds/slave/test',
02:23:45     INFO -  'blob_upload_branch': 'Mozilla-Aurora',
02:23:45     INFO -  'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
02:23:45     INFO -  'branch': 'Mozilla-Aurora',
02:23:45     INFO -  'buildbot_json_path': 'buildprops.json',
02:23:45     INFO -  'config_files': ('talos/mac_config.py',),
02:23:45     INFO -  'default_actions': ('clobber',
02:23:45     INFO -                      'read-buildbot-config',
02:23:45     INFO -                      'download-and-extract',
02:23:45     INFO -                      'populate-webroot',
02:23:45     INFO -                      'create-virtualenv',
02:23:45     INFO -                      'install',
02:23:45     INFO -                      'run-tests'),
02:23:45     INFO -  'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
02:23:45     INFO -  'download_minidump_stackwalk': True,
02:23:45     INFO -  'download_symbols': 'ondemand',
02:23:45     INFO -  'exes': {'python': '/tools/buildbot/bin/python',
02:23:45     INFO -           'tooltool.py': '/tools/tooltool.py',
02:23:45     INFO -           'virtualenv': ('/tools/buildbot/bin/python',
02:23:45     INFO -                          '/tools/misc-python/virtualenv.py')},
02:23:45     INFO -  'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
02:23:45     INFO -                 'http://pypi.pub.build.mozilla.org/pub'),
02:23:45     INFO -  'installer_path': 'installer.exe',
02:23:45     INFO -  'log_level': 'info',
02:23:45     INFO -  'log_name': 'talos',
02:23:45     INFO -  'log_to_console': True,
02:23:45     INFO -  'minidump_stackwalk_path': 'macosx64-minidump_stackwalk',
02:23:45     INFO -  'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest',
02:23:45     INFO -  'opt_config_files': (),
02:23:45     INFO -  'pip_index': False,
02:23:45     INFO -  'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'),
02:23:45     INFO -                                 'cmd': ('bash',
02:23:45     INFO -                                         '-c',
02:23:45     INFO -                                         'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'),
02:23:45     INFO -                                 'enabled': True,
02:23:45     INFO -                                 'halt_on_failure': False,
02:23:45     INFO -                                 'name': 'check_screen_resolution'},),
02:23:45     INFO -  'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'),
02:23:45     INFO -                                'cmd': ('bash',
02:23:45     INFO -                                        '-c',
02:23:45     INFO -                                        'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'),
02:23:45     INFO -                                'enabled': True,
02:23:45     INFO -                                'halt_on_failure': False,
02:23:45     INFO -                                'name': 'check_screen_resolution'},),
02:23:45     INFO -  'run_cmd_checks_enabled': True,
02:23:45     INFO -  'sps_profile': False,
02:23:45     INFO -  'sps_profile_interval': 0,
02:23:45     INFO -  'suite': 'other-e10s',
02:23:45     INFO -  'system_bits': '32',
02:23:45     INFO -  'talos_extra_options': ('--webServer', 'localhost'),
02:23:45     INFO -  'title': 't-yosemite-r7-0077',
02:23:45     INFO -  'tooltool_cache': '/builds/tooltool_cache',
02:23:45     INFO -  'use_talos_json': True,
02:23:45     INFO -  'virtualenv_path': '/builds/slave/test/build/venv',
02:23:45     INFO -  'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
02:23:45     INFO -  'work_dir': 'build'}
02:23:45     INFO - [mozharness: 2017-01-09 10:23:45.726538Z] Running clobber step.
02:23:45     INFO - Running pre-action listener: _resource_record_pre_action
02:23:45     INFO - Running main action method: clobber
02:23:45     INFO - rmtree: /builds/slave/test/build
02:23:45     INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
02:23:48     INFO - Running post-action listener: _resource_record_post_action
02:23:48     INFO - [mozharness: 2017-01-09 10:23:48.473487Z] Finished clobber step (success)
02:23:48     INFO - [mozharness: 2017-01-09 10:23:48.473641Z] Running read-buildbot-config step.
02:23:48     INFO - Running pre-action listener: _resource_record_pre_action
02:23:48     INFO - Running main action method: read_buildbot_config
02:23:48     INFO - Using buildbot properties:
02:23:48     INFO - {
02:23:48     INFO -     "project": "", 
02:23:48     INFO -     "product": "firefox", 
02:23:48     INFO -     "script_repo_revision": "production", 
02:23:48     INFO -     "builddir": "mozilla-aurora_yosemite_r7_test-other-e10s", 
02:23:48     INFO -     "repository": "", 
02:23:48     INFO -     "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos other-e10s", 
02:23:48     INFO -     "buildid": "20170108234108", 
02:23:48     INFO -     "pgo_build": "False", 
02:23:48     INFO -     "basedir": "/builds/slave/test", 
02:23:48     INFO -     "buildnumber": 39, 
02:23:48     INFO -     "slavename": "t-yosemite-r7-0077", 
02:23:48     INFO -     "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 
02:23:48     INFO -     "platform": "yosemite_r7", 
02:23:48     INFO -     "scheduler": "tests-mozilla-aurora-macosx64-talos", 
02:23:48     INFO -     "branch": "mozilla-aurora", 
02:23:48     INFO -     "repo_path": "releases/mozilla-aurora", 
02:23:48     INFO -     "revision": "fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86", 
02:23:48     INFO -     "stage_platform": "macosx64", 
02:23:48     INFO -     "builduid": "61c8c2b722174db491f223ed4bcb537d", 
02:23:48     INFO -     "slavebuilddir": "test"
02:23:48     INFO - }
02:23:48     INFO - Found installer url https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg.
02:23:48     INFO - Running post-action listener: _resource_record_post_action
02:23:48     INFO - [mozharness: 2017-01-09 10:23:48.476867Z] Finished read-buildbot-config step (success)
02:23:48     INFO - [mozharness: 2017-01-09 10:23:48.477003Z] Running download-and-extract step.
02:23:48     INFO - Running pre-action listener: _resource_record_pre_action
02:23:48     INFO - Running main action method: download_and_extract
02:23:48     INFO - mkdir: /builds/slave/test/build/tests
02:23:48     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
02:23:48     INFO - trying https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json
02:23:48     INFO - Downloading https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json
02:23:48     INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1
02:23:59     INFO - Downloaded 1199 bytes.
02:23:59     INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json
02:23:59     INFO - Using the following test package requirements:
02:23:59     INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'],
02:23:59     INFO -  u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip',
02:23:59     INFO -                   u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'],
02:23:59     INFO -  u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip',
02:23:59     INFO -             u'firefox-52.0a2.en-US.mac.gtest.tests.zip'],
02:23:59     INFO -  u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip',
02:23:59     INFO -               u'jsshell-mac.zip'],
02:23:59     INFO -  u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip',
02:23:59     INFO -                 u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'],
02:23:59     INFO -  u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'],
02:23:59     INFO -  u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip',
02:23:59     INFO -               u'firefox-52.0a2.en-US.mac.reftest.tests.zip'],
02:23:59     INFO -  u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip',
02:23:59     INFO -             u'firefox-52.0a2.en-US.mac.talos.tests.zip'],
02:23:59     INFO -  u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip',
02:23:59     INFO -                    u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'],
02:23:59     INFO -  u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip',
02:23:59     INFO -                u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']}
02:23:59     INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common
02:23:59     INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip
02:23:59     INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1
02:23:59     INFO - Fetch https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory
02:24:00     INFO - Http code: 200
02:24:00     INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront)
02:24:00     INFO - x-amz-cf-id: Ze4Y2V1i2F-i3vBIqc5vMTn1zKJASqzv-PbkWin2eIzorNo6pGgItg==
02:24:00     INFO - x-amz-version-id: ..QJpBJvoMS2gJB8PzVp_yTknCVzZpgs
02:24:01     INFO - Expected file size: 16270960
02:24:01     INFO - Obtained file size: 16270960
02:24:07     INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos
02:24:07     INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip
02:24:07     INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1
02:24:07     INFO - Fetch https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory
02:24:40     INFO - retry: attempt #1 caught exception: ''
02:24:40     INFO - retry: Failed, sleeping 60 seconds before retrying
02:25:40     INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #2
02:25:40     INFO - Fetch https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory
02:25:43     INFO - Http code: 200
02:25:43     INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront)
02:25:43     INFO - x-amz-cf-id: E3ZRrHWhuIRA6mXYH6QFGH0OuKaJm00szNQuRo5LL9pgx3oA3jCruA==
02:25:43     INFO - x-amz-version-id: ..QJpBJvoMS2gJB8PzVp_yTknCVzZpgs
02:25:43     INFO - Expected file size: 16270960
02:25:43     INFO - Obtained file size: 16270960
02:25:49     INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip
02:25:49     INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1
02:25:49     INFO - Fetch https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory
02:25:51     INFO - Http code: 200
02:25:51     INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront)
02:25:51     INFO - x-amz-cf-id: Rl9m4tufatPsPuWdrpzUHhox6iJ_yBdrIFef86qnYJiaCTTz_Sx9_Q==
02:25:51     INFO - x-amz-version-id: HzIUwkurC25uciVA5KuJUMLMrxs.c_3N
02:25:52     INFO - Expected file size: 14409038
02:25:52     INFO - Obtained file size: 14409038
02:25:52     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
02:25:52     INFO - trying https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg
02:25:52     INFO - Downloading https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg
02:25:52     INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1
02:26:24     INFO - retry: attempt #1 caught exception: ''
02:26:24     INFO - retry: Failed, sleeping 30 seconds before retrying
02:26:54     INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #2
02:27:01     INFO - Downloaded 109878872 bytes.
02:27:01     INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg
02:27:01     INFO - mkdir: /builds/slave/test/properties
02:27:01     INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
02:27:01     INFO - Writing to file /builds/slave/test/properties/build_url
02:27:01     INFO - Contents:
02:27:01     INFO -  build_url:https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg
02:27:32     INFO - Running post-action listener: _resource_record_post_action
02:27:32     INFO - Running post-action listener: set_extra_try_arguments
02:27:32     INFO - [mozharness: 2017-01-09 10:27:32.584574Z] Finished download-and-extract step (failed)
02:27:32    FATAL - Uncaught exception: Traceback (most recent call last):
02:27:32    FATAL -   File "/builds/slave/test/scripts/mozharness/base/script.py", line 2034, in run
02:27:32    FATAL -     self.run_action(action)
02:27:32    FATAL -   File "/builds/slave/test/scripts/mozharness/base/script.py", line 1973, in run_action
02:27:32    FATAL -     self._possibly_run_method(method_name, error_if_missing=True)
02:27:32    FATAL -   File "/builds/slave/test/scripts/mozharness/base/script.py", line 1913, in _possibly_run_method
02:27:32    FATAL -     return getattr(self, method_name)()
02:27:32    FATAL -   File "/builds/slave/test/scripts/mozharness/mozilla/testing/talos.py", line 302, in download_and_extract
02:27:32    FATAL -     suite_categories=['common', 'talos']
02:27:32    FATAL -   File "/builds/slave/test/scripts/mozharness/mozilla/testing/testbase.py", line 569, in download_and_extract
02:27:32    FATAL -     self._download_and_extract_symbols()
02:27:32    FATAL -   File "/builds/slave/test/scripts/mozharness/mozilla/testing/testbase.py", line 511, in _download_and_extract_symbols
02:27:32    FATAL -     self.symbols_url = self.query_symbols_url()
02:27:32    FATAL -   File "/builds/slave/test/scripts/mozharness/mozilla/testing/testbase.py", line 201, in query_symbols_url
02:27:32    FATAL -     self._urlopen(symbols_url, timeout=120)
02:27:32    FATAL -   File "/builds/slave/test/scripts/mozharness/mozilla/testing/testbase.py", line 293, in _urlopen
02:27:32    FATAL -     return urllib2.urlopen(url, **kwargs)
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/urllib2.py", line 126, in urlopen
02:27:32    FATAL -     return _opener.open(url, data, timeout)
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/urllib2.py", line 406, in open
02:27:32    FATAL -     response = meth(req, response)
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/urllib2.py", line 519, in http_response
02:27:32    FATAL -     'http', request, response, code, msg, hdrs)
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/urllib2.py", line 438, in error
02:27:32    FATAL -     result = self._call_chain(*args)
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/urllib2.py", line 378, in _call_chain
02:27:32    FATAL -     result = func(*args)
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/urllib2.py", line 625, in http_error_302
02:27:32    FATAL -     return self.parent.open(new, timeout=req.timeout)
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/urllib2.py", line 400, in open
02:27:32    FATAL -     response = self._open(req, data)
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/urllib2.py", line 418, in _open
02:27:32    FATAL -     '_open', req)
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/urllib2.py", line 378, in _call_chain
02:27:32    FATAL -     result = func(*args)
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/urllib2.py", line 1215, in https_open
02:27:32    FATAL -     return self.do_open(httplib.HTTPSConnection, req)
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/urllib2.py", line 1180, in do_open
02:27:32    FATAL -     r = h.getresponse(buffering=True)
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/httplib.py", line 1030, in getresponse
02:27:32    FATAL -     response.begin()
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/httplib.py", line 407, in begin
02:27:32    FATAL -     version, status, reason = self._read_status()
02:27:32    FATAL -   File "/tools/python27/lib/python2.7/httplib.py", line 371, in _read_status
02:27:32    FATAL -     raise BadStatusLine(line)
02:27:32    FATAL - BadStatusLine: ''
02:27:32    FATAL - Running post_fatal callback...
02:27:32    FATAL - Exiting -1
02:27:32     INFO - Running post-run listener: _resource_record_post_run
02:27:32     INFO - Running post-run listener: _upload_blobber_files
02:27:32     INFO - Blob upload gear active.
02:27:32  WARNING - Blob upload directory does not exist!
02:27:32     INFO - Running post-run listener: copy_logs_to_upload_dir
02:27:32     INFO - Copying logs to upload dir...
02:27:32     INFO - mkdir: /builds/slave/test/build/upload/logs
program finished with exit code 255
elapsedTime=227.086160
========= master_lag: 1.01 =========
========= Finished '/tools/buildbot/bin/python -u ...' failed (results: 2, elapsed: 3 mins, 48 secs) (at 2017-01-09 02:27:33.358091) =========

========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2017-01-09 02:27:33.359607) =========
bash -c 'for file in `ls -1`; do cat $file; done'
 in dir /builds/slave/test/properties (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done']
 environment:
  Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YFWwinauDy/Render
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_NO_REMOTE=1
  NO_EM_RESTART=1
  PAGER=/bin/cat
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/test/properties
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ye2gxLXUIU/Listeners
  TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  XPCOM_DEBUG_BREAK=warn
  XPC_FLAGS=0x0
  XPC_SERVICE_NAME=0
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
build_url:https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg
program finished with exit code 0
elapsedTime=0.009267
build_url: 'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg'
========= master_lag: 0.02 =========
========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2017-01-09 02:27:33.392435) =========

========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:27:33.392776) =========
rm -f oauth.txt
 in dir /builds/slave/test/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-f', 'oauth.txt']
 environment:
  Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YFWwinauDy/Render
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_NO_REMOTE=1
  NO_EM_RESTART=1
  PAGER=/bin/cat
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/test
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ye2gxLXUIU/Listeners
  TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  XPCOM_DEBUG_BREAK=warn
  XPC_FLAGS=0x0
  XPC_SERVICE_NAME=0
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
program finished with exit code 0
elapsedTime=0.004973
========= master_lag: 0.04 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:27:33.441698) =========

========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 02:27:33.442029) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 02:27:33.442347) =========

========= Total master_lag: 27.22 =========