builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0072 starttime: 1455840746.53 results: success (0) buildid: 20160218135626 builduid: 27af7f810697409db983d71ea6eb2609 revision: cdc8bb2a48aec0970da93ba8d78cf11e851ed2bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 16:12:26.525430) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 16:12:26.526028) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2016-02-18 16:12:26.526316) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fcMJ8FWzjR/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.g2hI1nn215/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005616 basedir: '/builds/slave/test' ========= master_lag: 1.69 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2016-02-18 16:12:28.220809) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-02-18 16:12:28.221124) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-02-18 16:12:37.320704) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-02-18 16:12:37.320973) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fcMJ8FWzjR/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.g2hI1nn215/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005237 ========= master_lag: 6.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-02-18 16:12:43.514373) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 16:12:43.518645) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 16:12:43.519043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:12:43.519338) ========= 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.fcMJ8FWzjR/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.g2hI1nn215/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 --2016-02-18 16:12:44-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 45.2M=0s 2016-02-18 16:12:44 (45.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123905 ========= master_lag: 0.78 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:12:44.421747) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 18 secs) (at 2016-02-18 16:12:44.422075) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fcMJ8FWzjR/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.g2hI1nn215/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.019010 ========= master_lag: 18.29 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 18 secs) (at 2016-02-18 16:13:02.732497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 16:13:02.732934) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cdc8bb2a48aec0970da93ba8d78cf11e851ed2bd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cdc8bb2a48aec0970da93ba8d78cf11e851ed2bd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fcMJ8FWzjR/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.g2hI1nn215/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 2016-02-18 16:13:03,054 truncating revision to first 12 chars 2016-02-18 16:13:03,055 Setting DEBUG logging. 2016-02-18 16:13:03,055 attempt 1/10 2016-02-18 16:13:03,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cdc8bb2a48ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 16:13:03,654 unpacking tar archive at: mozilla-central-cdc8bb2a48ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.843599 ========= master_lag: 0.61 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 16:13:04.191055) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-02-18 16:13:04.191348) ========= echo cdc8bb2a48aec0970da93ba8d78cf11e851ed2bd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'cdc8bb2a48aec0970da93ba8d78cf11e851ed2bd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fcMJ8FWzjR/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.g2hI1nn215/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 cdc8bb2a48aec0970da93ba8d78cf11e851ed2bd program finished with exit code 0 elapsedTime=0.005138 script_repo_revision: 'cdc8bb2a48aec0970da93ba8d78cf11e851ed2bd' ========= master_lag: 1.76 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-02-18 16:13:05.957672) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 7 secs) (at 2016-02-18 16:13:05.962444) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 7 secs) (at 2016-02-18 16:13:13.603046) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-18 16:13:13.603315) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fcMJ8FWzjR/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.g2hI1nn215/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 16:13:14 INFO - MultiFileLogger online at 20160218 16:13:14 in /builds/slave/test 16:13:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:13:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:13:14 INFO - {'append_to_log': False, 16:13:14 INFO - 'base_work_dir': '/builds/slave/test', 16:13:14 INFO - 'blob_upload_branch': 'Firefox', 16:13:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:13:14 INFO - 'branch': 'Firefox', 16:13:14 INFO - 'buildbot_json_path': 'buildprops.json', 16:13:14 INFO - 'config_files': ('talos/mac_config.py',), 16:13:14 INFO - 'default_actions': ('clobber', 16:13:14 INFO - 'read-buildbot-config', 16:13:14 INFO - 'download-and-extract', 16:13:14 INFO - 'populate-webroot', 16:13:14 INFO - 'create-virtualenv', 16:13:14 INFO - 'install', 16:13:14 INFO - 'run-tests'), 16:13:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:13:14 INFO - 'download_minidump_stackwalk': True, 16:13:14 INFO - 'download_symbols': 'ondemand', 16:13:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:13:14 INFO - 'tooltool.py': '/tools/tooltool.py', 16:13:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:13:14 INFO - '/tools/misc-python/virtualenv.py')}, 16:13:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:13:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:13:14 INFO - 'installer_path': 'installer.exe', 16:13:14 INFO - 'log_level': 'info', 16:13:14 INFO - 'log_name': 'talos', 16:13:14 INFO - 'log_to_console': True, 16:13:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:13:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:13:14 INFO - 'opt_config_files': (), 16:13:14 INFO - 'pip_index': False, 16:13:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:13:14 INFO - 'cmd': ('bash', 16:13:14 INFO - '-c', 16:13:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:13:14 INFO - 'enabled': True, 16:13:14 INFO - 'halt_on_failure': False, 16:13:14 INFO - 'name': 'check_screen_resolution'},), 16:13:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:13:14 INFO - 'cmd': ('bash', 16:13:14 INFO - '-c', 16:13:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:13:14 INFO - 'enabled': True, 16:13:14 INFO - 'halt_on_failure': False, 16:13:14 INFO - 'name': 'check_screen_resolution'},), 16:13:14 INFO - 'run_cmd_checks_enabled': True, 16:13:14 INFO - 'sps_profile': False, 16:13:14 INFO - 'sps_profile_interval': 0, 16:13:14 INFO - 'suite': 'dromaeojs-e10s', 16:13:14 INFO - 'system_bits': '32', 16:13:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:13:14 INFO - 'title': 't-yosemite-r7-0072', 16:13:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:13:14 INFO - 'use_talos_json': True, 16:13:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:13:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:13:14 INFO - 'work_dir': 'build'} 16:13:14 INFO - ##### 16:13:14 INFO - ##### Running clobber step. 16:13:14 INFO - ##### 16:13:14 INFO - Running pre-action listener: _resource_record_pre_action 16:13:14 INFO - Running main action method: clobber 16:13:14 INFO - rmtree: /builds/slave/test/build 16:13:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:13:15 INFO - Running post-action listener: _resource_record_post_action 16:13:15 INFO - ##### 16:13:15 INFO - ##### Running read-buildbot-config step. 16:13:15 INFO - ##### 16:13:15 INFO - Running pre-action listener: _resource_record_pre_action 16:13:15 INFO - Running main action method: read_buildbot_config 16:13:15 INFO - Using buildbot properties: 16:13:15 INFO - { 16:13:15 INFO - "project": "", 16:13:15 INFO - "product": "firefox", 16:13:15 INFO - "script_repo_revision": "production", 16:13:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 16:13:15 INFO - "repository": "", 16:13:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 16:13:15 INFO - "buildid": "20160218135626", 16:13:15 INFO - "pgo_build": "False", 16:13:15 INFO - "basedir": "/builds/slave/test", 16:13:15 INFO - "buildnumber": 136, 16:13:15 INFO - "slavename": "t-yosemite-r7-0072", 16:13:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:13:15 INFO - "platform": "yosemite_r7", 16:13:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:13:15 INFO - "branch": "mozilla-central", 16:13:15 INFO - "repo_path": "mozilla-central", 16:13:15 INFO - "revision": "cdc8bb2a48aec0970da93ba8d78cf11e851ed2bd", 16:13:15 INFO - "stage_platform": "macosx64", 16:13:15 INFO - "builduid": "27af7f810697409db983d71ea6eb2609", 16:13:15 INFO - "slavebuilddir": "test" 16:13:15 INFO - } 16:13:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 16:13:15 INFO - Running post-action listener: _resource_record_post_action 16:13:15 INFO - ##### 16:13:15 INFO - ##### Running download-and-extract step. 16:13:15 INFO - ##### 16:13:15 INFO - Running pre-action listener: _resource_record_pre_action 16:13:15 INFO - Running main action method: download_and_extract 16:13:15 INFO - mkdir: /builds/slave/test/build/tests 16:13:15 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:15 INFO - https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:13:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/test_packages.json 16:13:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/test_packages.json 16:13:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:13:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:13:16 INFO - Downloaded 1277 bytes. 16:13:16 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:13:16 INFO - Using the following test package requirements: 16:13:16 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:13:16 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:16 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 16:13:16 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:16 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 16:13:16 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:16 INFO - u'jsshell-mac.zip'], 16:13:16 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:16 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 16:13:16 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:13:16 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:16 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 16:13:16 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:16 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 16:13:16 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:16 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 16:13:16 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:13:16 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:16 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 16:13:16 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:13:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:16 INFO - https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:13:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:13:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:13:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:13:18 INFO - Downloaded 17807338 bytes. 16:13:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:13:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:13:21 INFO - Return code: 0 16:13:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:13:21 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:21 INFO - https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:13:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:13:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:13:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:13:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:13:22 INFO - Downloaded 17807338 bytes. 16:13:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:13:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:13:26 INFO - Return code: 0 16:13:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:26 INFO - https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:13:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:13:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:13:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:13:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:13:27 INFO - Downloaded 10707071 bytes. 16:13:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:13:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:13:27 INFO - Return code: 0 16:13:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:27 INFO - https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:13:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:13:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:13:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 16:13:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 16:13:31 INFO - Downloaded 111345234 bytes. 16:13:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:13:31 INFO - mkdir: /builds/slave/test/properties 16:13:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:13:31 INFO - Writing to file /builds/slave/test/properties/build_url 16:13:31 INFO - Contents: 16:13:31 INFO - build_url:https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:13:32 INFO - Running post-action listener: _resource_record_post_action 16:13:32 INFO - Running post-action listener: set_extra_try_arguments 16:13:32 INFO - ##### 16:13:32 INFO - ##### Running populate-webroot step. 16:13:32 INFO - ##### 16:13:32 INFO - Running pre-action listener: _resource_record_pre_action 16:13:32 INFO - Running main action method: populate_webroot 16:13:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:13:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:13:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:13:32 INFO - '--tppagecycles', 16:13:32 INFO - '7'], 16:13:32 INFO - 'tests': ['tsvgm']}}, 16:13:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:13:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:13:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:13:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:13:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:13:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:13:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:32 INFO - 'talos_options': ['--e10s'], 16:13:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:32 INFO - 'tests': ['damp', 'tps']}, 16:13:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:32 INFO - 'talos_options': ['--e10s'], 16:13:32 INFO - 'tests': ['damp', 'tps']}, 16:13:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:13:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:13:32 INFO - 'other': {'tests': ['a11yr', 16:13:32 INFO - 'ts_paint', 16:13:32 INFO - 'tpaint', 16:13:32 INFO - 'sessionrestore', 16:13:32 INFO - 'sessionrestore_no_auto_restore']}, 16:13:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:13:32 INFO - 'tests': ['a11yr', 16:13:32 INFO - 'ts_paint', 16:13:32 INFO - 'tpaint', 16:13:32 INFO - 'sessionrestore', 16:13:32 INFO - 'sessionrestore_no_auto_restore']}, 16:13:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:13:32 INFO - 'tests': ['a11yr', 16:13:32 INFO - 'ts_paint', 16:13:32 INFO - 'tpaint', 16:13:32 INFO - 'sessionrestore', 16:13:32 INFO - 'sessionrestore_no_auto_restore']}, 16:13:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:13:32 INFO - 'tests': ['a11yr', 16:13:32 INFO - 'ts_paint', 16:13:32 INFO - 'tpaint', 16:13:32 INFO - 'sessionrestore', 16:13:32 INFO - 'sessionrestore_no_auto_restore']}, 16:13:32 INFO - 'other_l64': {'tests': ['a11yr', 16:13:32 INFO - 'ts_paint', 16:13:32 INFO - 'tpaint', 16:13:32 INFO - 'sessionrestore', 16:13:32 INFO - 'sessionrestore_no_auto_restore']}, 16:13:32 INFO - 'other_nol64': {'tests': ['a11yr', 16:13:32 INFO - 'ts_paint', 16:13:32 INFO - 'tpaint', 16:13:32 INFO - 'sessionrestore', 16:13:32 INFO - 'sessionrestore_no_auto_restore']}, 16:13:32 INFO - 'svgr': {'tests': ['tsvgx', 16:13:32 INFO - 'tsvgr_opacity', 16:13:32 INFO - 'tart', 16:13:32 INFO - 'tscrollx', 16:13:32 INFO - 'cart']}, 16:13:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:13:32 INFO - 'tests': ['tsvgx', 16:13:32 INFO - 'tsvgr_opacity', 16:13:32 INFO - 'tart', 16:13:32 INFO - 'tscrollx', 16:13:32 INFO - 'cart']}, 16:13:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:32 INFO - 'tests': ['tp5o']}, 16:13:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:32 INFO - 'talos_options': ['--e10s'], 16:13:32 INFO - 'tests': ['tp5o']}, 16:13:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:32 INFO - 'talos_options': ['--xperf_path', 16:13:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:32 INFO - 'tests': ['tp5n']}, 16:13:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:32 INFO - 'talos_options': ['--e10s', 16:13:32 INFO - '--xperf_path', 16:13:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:32 INFO - 'tests': ['tp5n']}}, 16:13:32 INFO - 'talos.zip': {'path': '', 16:13:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:13:32 INFO - Running post-action listener: _resource_record_post_action 16:13:32 INFO - ##### 16:13:32 INFO - ##### Running create-virtualenv step. 16:13:32 INFO - ##### 16:13:32 INFO - Running pre-action listener: _resource_record_pre_action 16:13:32 INFO - Running main action method: create_virtualenv 16:13:32 INFO - Creating virtualenv /builds/slave/test/build/venv 16:13:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:13:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:13:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:13:32 INFO - Using real prefix '/tools/python27' 16:13:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:13:33 INFO - Installing distribute.............................................................................................................................................................................................done. 16:13:36 INFO - Installing pip.................done. 16:13:36 INFO - Return code: 0 16:13:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:13:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103360a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedba56db90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103204d30>, '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 0x103028db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:13:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 16:13:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:36 INFO - 'HOME': '/Users/cltbld', 16:13:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:36 INFO - 'LOGNAME': 'cltbld', 16:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:36 INFO - 'MOZ_NO_REMOTE': '1', 16:13:36 INFO - 'NO_EM_RESTART': '1', 16:13:36 INFO - 'PAGER': '/bin/cat', 16:13:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:36 INFO - 'PWD': '/builds/slave/test', 16:13:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:36 INFO - 'SHELL': '/bin/bash', 16:13:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 16:13:36 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:13:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:36 INFO - 'USER': 'cltbld', 16:13:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:36 INFO - 'XPC_FLAGS': '0x0', 16:13:36 INFO - 'XPC_SERVICE_NAME': '0', 16:13:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:13:36 INFO - Cleaning up... 16:13:36 INFO - Return code: 0 16:13:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:13:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103360a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedba56db90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103204d30>, '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 0x103028db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:13:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 16:13:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:36 INFO - 'HOME': '/Users/cltbld', 16:13:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:36 INFO - 'LOGNAME': 'cltbld', 16:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:36 INFO - 'MOZ_NO_REMOTE': '1', 16:13:36 INFO - 'NO_EM_RESTART': '1', 16:13:36 INFO - 'PAGER': '/bin/cat', 16:13:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:36 INFO - 'PWD': '/builds/slave/test', 16:13:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:36 INFO - 'SHELL': '/bin/bash', 16:13:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 16:13:36 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:13:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:36 INFO - 'USER': 'cltbld', 16:13:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:36 INFO - 'XPC_FLAGS': '0x0', 16:13:36 INFO - 'XPC_SERVICE_NAME': '0', 16:13:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:36 INFO - Downloading/unpacking psutil>=0.7.1 16:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:13:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:39 INFO - Installing collected packages: psutil 16:13:39 INFO - Running setup.py install for psutil 16:13:40 INFO - building 'psutil._psutil_osx' extension 16:13:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:13:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:13:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:13:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:13:40 INFO - building 'psutil._psutil_posix' extension 16:13:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:13:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:13:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:13:40 INFO - ^ 16:13:40 INFO - 1 warning generated. 16:13:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:13:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:40 INFO - Successfully installed psutil 16:13:40 INFO - Cleaning up... 16:13:40 INFO - Return code: 0 16:13:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:13:40 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:40 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103360a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedba56db90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103204d30>, '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 0x103028db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:13:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:13:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:13:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 16:13:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:40 INFO - 'HOME': '/Users/cltbld', 16:13:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:40 INFO - 'LOGNAME': 'cltbld', 16:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:40 INFO - 'MOZ_NO_REMOTE': '1', 16:13:40 INFO - 'NO_EM_RESTART': '1', 16:13:40 INFO - 'PAGER': '/bin/cat', 16:13:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:40 INFO - 'PWD': '/builds/slave/test', 16:13:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:40 INFO - 'SHELL': '/bin/bash', 16:13:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 16:13:40 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:13:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:40 INFO - 'USER': 'cltbld', 16:13:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:40 INFO - 'XPC_FLAGS': '0x0', 16:13:40 INFO - 'XPC_SERVICE_NAME': '0', 16:13:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:13:43 INFO - Installing collected packages: mozsystemmonitor 16:13:43 INFO - Running setup.py install for mozsystemmonitor 16:13:43 INFO - Successfully installed mozsystemmonitor 16:13:43 INFO - Cleaning up... 16:13:43 INFO - Return code: 0 16:13:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:13:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103360a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedba56db90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103204d30>, '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 0x103028db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:13:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:13:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 16:13:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:43 INFO - 'HOME': '/Users/cltbld', 16:13:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:43 INFO - 'LOGNAME': 'cltbld', 16:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:43 INFO - 'MOZ_NO_REMOTE': '1', 16:13:43 INFO - 'NO_EM_RESTART': '1', 16:13:43 INFO - 'PAGER': '/bin/cat', 16:13:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:43 INFO - 'PWD': '/builds/slave/test', 16:13:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:43 INFO - 'SHELL': '/bin/bash', 16:13:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 16:13:43 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:13:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:43 INFO - 'USER': 'cltbld', 16:13:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:43 INFO - 'XPC_FLAGS': '0x0', 16:13:43 INFO - 'XPC_SERVICE_NAME': '0', 16:13:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:43 INFO - Downloading/unpacking blobuploader==1.2.4 16:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:46 INFO - Downloading blobuploader-1.2.4.tar.gz 16:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:13:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:13:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:47 INFO - Downloading docopt-0.6.1.tar.gz 16:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:13:47 INFO - Installing collected packages: blobuploader, requests, docopt 16:13:47 INFO - Running setup.py install for blobuploader 16:13:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:13:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:13:47 INFO - Running setup.py install for requests 16:13:48 INFO - Running setup.py install for docopt 16:13:48 INFO - Successfully installed blobuploader requests docopt 16:13:48 INFO - Cleaning up... 16:13:48 INFO - Return code: 0 16:13:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103360a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedba56db90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103204d30>, '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 0x103028db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:13:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:13:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 16:13:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:48 INFO - 'HOME': '/Users/cltbld', 16:13:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:48 INFO - 'LOGNAME': 'cltbld', 16:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:48 INFO - 'MOZ_NO_REMOTE': '1', 16:13:48 INFO - 'NO_EM_RESTART': '1', 16:13:48 INFO - 'PAGER': '/bin/cat', 16:13:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:48 INFO - 'PWD': '/builds/slave/test', 16:13:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:48 INFO - 'SHELL': '/bin/bash', 16:13:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 16:13:48 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:13:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:48 INFO - 'USER': 'cltbld', 16:13:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:48 INFO - 'XPC_FLAGS': '0x0', 16:13:48 INFO - 'XPC_SERVICE_NAME': '0', 16:13:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-G1np8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-rrZBPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-KLzDNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-UzwUHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-O2noit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-MzsElW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-PGZxgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-caJSB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-dSzHu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-IJajbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-UEuB8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-gcnauL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-e8jOKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-oGhBkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:50 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-4NBomX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:50 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-_EuBOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:50 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-TJblSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:13:50 INFO - Running setup.py install for manifestparser 16:13:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:13:50 INFO - Running setup.py install for mozcrash 16:13:50 INFO - Running setup.py install for mozdebug 16:13:50 INFO - Running setup.py install for mozdevice 16:13:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:13:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:13:50 INFO - Running setup.py install for mozfile 16:13:51 INFO - Running setup.py install for mozhttpd 16:13:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:13:51 INFO - Running setup.py install for mozinfo 16:13:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:13:51 INFO - Running setup.py install for mozInstall 16:13:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:13:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:13:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:13:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:13:51 INFO - Running setup.py install for mozleak 16:13:51 INFO - Running setup.py install for mozlog 16:13:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:13:51 INFO - Running setup.py install for moznetwork 16:13:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:13:51 INFO - Running setup.py install for mozprocess 16:13:52 INFO - Running setup.py install for mozprofile 16:13:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Running setup.py install for mozrunner 16:13:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Running setup.py install for mozscreenshot 16:13:52 INFO - Running setup.py install for moztest 16:13:52 INFO - Running setup.py install for mozversion 16:13:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:13:52 INFO - Cleaning up... 16:13:52 INFO - Return code: 0 16:13:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103360a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedba56db90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103204d30>, '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 0x103028db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:13:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 16:13:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:52 INFO - 'HOME': '/Users/cltbld', 16:13:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:52 INFO - 'LOGNAME': 'cltbld', 16:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:52 INFO - 'MOZ_NO_REMOTE': '1', 16:13:52 INFO - 'NO_EM_RESTART': '1', 16:13:52 INFO - 'PAGER': '/bin/cat', 16:13:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:52 INFO - 'PWD': '/builds/slave/test', 16:13:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:52 INFO - 'SHELL': '/bin/bash', 16:13:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 16:13:52 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:13:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:52 INFO - 'USER': 'cltbld', 16:13:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:52 INFO - 'XPC_FLAGS': '0x0', 16:13:52 INFO - 'XPC_SERVICE_NAME': '0', 16:13:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:53 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-KFHOq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:53 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Z3RPfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:53 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-n9KU67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:53 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-20SVgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:53 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-TxVRDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:53 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-x6u9DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:53 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-G7cpyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:53 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Z3JjFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:54 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-N9Mflb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:54 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-x8Mgtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:54 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-bmsU9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:54 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-SHLW8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:54 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-q0SRz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:54 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-MMo3Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:54 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-R67rQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:54 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Zz7Zav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:54 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-GnRaMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:13:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:57 INFO - Downloading blessings-1.6.tar.gz 16:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:13:57 INFO - Installing collected packages: blessings 16:13:57 INFO - Running setup.py install for blessings 16:13:57 INFO - Successfully installed blessings 16:13:57 INFO - Cleaning up... 16:13:57 INFO - Return code: 0 16:13:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:13:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:57 INFO - Reading from file tmpfile_stdout 16:13:57 INFO - Current package versions: 16:13:57 INFO - blessings == 1.6 16:13:57 INFO - blobuploader == 1.2.4 16:13:57 INFO - docopt == 0.6.1 16:13:57 INFO - manifestparser == 1.1 16:13:57 INFO - mozInstall == 1.12 16:13:57 INFO - mozcrash == 0.16 16:13:57 INFO - mozdebug == 0.1 16:13:57 INFO - mozdevice == 0.48 16:13:57 INFO - mozfile == 1.2 16:13:57 INFO - mozhttpd == 0.7 16:13:57 INFO - mozinfo == 0.9 16:13:57 INFO - mozleak == 0.1 16:13:57 INFO - mozlog == 3.1 16:13:57 INFO - moznetwork == 0.27 16:13:57 INFO - mozprocess == 0.22 16:13:57 INFO - mozprofile == 0.28 16:13:57 INFO - mozrunner == 6.11 16:13:57 INFO - mozscreenshot == 0.1 16:13:57 INFO - mozsystemmonitor == 0.0 16:13:57 INFO - moztest == 0.7 16:13:57 INFO - mozversion == 1.4 16:13:57 INFO - psutil == 3.1.1 16:13:57 INFO - requests == 1.2.3 16:13:57 INFO - wsgiref == 0.1.2 16:13:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103360a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedba56db90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103204d30>, '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 0x103028db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:13:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 16:13:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:57 INFO - 'HOME': '/Users/cltbld', 16:13:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:57 INFO - 'LOGNAME': 'cltbld', 16:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:57 INFO - 'MOZ_NO_REMOTE': '1', 16:13:57 INFO - 'NO_EM_RESTART': '1', 16:13:57 INFO - 'PAGER': '/bin/cat', 16:13:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:57 INFO - 'PWD': '/builds/slave/test', 16:13:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:57 INFO - 'SHELL': '/bin/bash', 16:13:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 16:13:57 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:13:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:57 INFO - 'USER': 'cltbld', 16:13:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:57 INFO - 'XPC_FLAGS': '0x0', 16:13:57 INFO - 'XPC_SERVICE_NAME': '0', 16:13:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:13:58 INFO - Cleaning up... 16:13:58 INFO - Return code: 0 16:13:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:13:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103360a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedba56db90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103204d30>, '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 0x103028db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:13:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 16:13:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:58 INFO - 'HOME': '/Users/cltbld', 16:13:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:58 INFO - 'LOGNAME': 'cltbld', 16:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:58 INFO - 'MOZ_NO_REMOTE': '1', 16:13:58 INFO - 'NO_EM_RESTART': '1', 16:13:58 INFO - 'PAGER': '/bin/cat', 16:13:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:58 INFO - 'PWD': '/builds/slave/test', 16:13:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:58 INFO - 'SHELL': '/bin/bash', 16:13:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 16:13:58 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:13:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:58 INFO - 'USER': 'cltbld', 16:13:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:58 INFO - 'XPC_FLAGS': '0x0', 16:13:58 INFO - 'XPC_SERVICE_NAME': '0', 16:13:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:58 INFO - Downloading/unpacking jsonschema 16:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:14:00 INFO - Downloading/unpacking functools32 (from jsonschema) 16:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:01 INFO - Downloading functools32-3.2.3-2.tar.gz 16:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:14:01 INFO - warning: no files found matching '*.txt' 16:14:01 INFO - no previously-included directories found matching 'build' 16:14:01 INFO - no previously-included directories found matching 'dist' 16:14:01 INFO - no previously-included directories found matching '.git*' 16:14:01 INFO - Installing collected packages: jsonschema, functools32 16:14:01 INFO - Running setup.py install for functools32 16:14:01 INFO - warning: no files found matching '*.txt' 16:14:01 INFO - no previously-included directories found matching 'build' 16:14:01 INFO - no previously-included directories found matching 'dist' 16:14:01 INFO - no previously-included directories found matching '.git*' 16:14:01 INFO - Successfully installed jsonschema functools32 16:14:01 INFO - Cleaning up... 16:14:01 INFO - Return code: 0 16:14:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:14:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103360a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedba56db90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103204d30>, '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 0x103028db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:14:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 16:14:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:01 INFO - 'HOME': '/Users/cltbld', 16:14:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:01 INFO - 'LOGNAME': 'cltbld', 16:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:01 INFO - 'MOZ_NO_REMOTE': '1', 16:14:01 INFO - 'NO_EM_RESTART': '1', 16:14:01 INFO - 'PAGER': '/bin/cat', 16:14:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:01 INFO - 'PWD': '/builds/slave/test', 16:14:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:01 INFO - 'SHELL': '/bin/bash', 16:14:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 16:14:01 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:14:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:01 INFO - 'USER': 'cltbld', 16:14:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:01 INFO - 'XPC_FLAGS': '0x0', 16:14:01 INFO - 'XPC_SERVICE_NAME': '0', 16:14:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:01 INFO - Downloading/unpacking flake8 16:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:14:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:14:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:14:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:14:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:14:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:14:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:14:05 INFO - no previously-included directories found matching 'docs/_build' 16:14:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:14:05 INFO - Running setup.py install for pep8 16:14:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:14:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:14:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:14:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:14:05 INFO - no previously-included directories found matching 'docs/_build' 16:14:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:14:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:14:05 INFO - Cleaning up... 16:14:05 INFO - Return code: 0 16:14:05 INFO - Running post-action listener: _resource_record_post_action 16:14:05 INFO - Running post-action listener: _start_resource_monitoring 16:14:05 INFO - Starting resource monitoring. 16:14:05 INFO - ##### 16:14:05 INFO - ##### Running install step. 16:14:05 INFO - ##### 16:14:05 INFO - Running pre-action listener: _resource_record_pre_action 16:14:05 INFO - Running main action method: install 16:14:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:05 INFO - Reading from file tmpfile_stdout 16:14:05 INFO - Detecting whether we're running mozinstall >=1.0... 16:14:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:14:06 INFO - Reading from file tmpfile_stdout 16:14:06 INFO - Output received: 16:14:06 INFO - Usage: mozinstall [options] installer 16:14:06 INFO - Options: 16:14:06 INFO - -h, --help show this help message and exit 16:14:06 INFO - -d DEST, --destination=DEST 16:14:06 INFO - Directory to install application into. [default: 16:14:06 INFO - "/builds/slave/test"] 16:14:06 INFO - --app=APP Application being installed. [default: firefox] 16:14:06 INFO - mkdir: /builds/slave/test/build/application 16:14:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:14:39 INFO - Reading from file tmpfile_stdout 16:14:39 INFO - Output received: 16:14:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:14:39 INFO - Running post-action listener: _resource_record_post_action 16:14:39 INFO - ##### 16:14:39 INFO - ##### Running run-tests step. 16:14:39 INFO - ##### 16:14:39 INFO - Running pre-action listener: _resource_record_pre_action 16:14:39 INFO - Running main action method: run_tests 16:14:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:14:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:14:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:14:39 INFO - 2016-02-18 16:14:39.498 screenresolution[1952:11712] starting screenresolution argv=screenresolution get 16:14:39 INFO - 2016-02-18 16:14:39.501 screenresolution[1952:11712] Display 0: 1600x1200x32@60 16:14:39 INFO - 2016-02-18 16:14:39.506 screenresolution[1953:11714] starting screenresolution argv=screenresolution list 16:14:39 INFO - Available Modes on Display 0 16:14:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:14:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:14:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:14:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:14:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:14:39 INFO - Intel Iris: 16:14:39 INFO - Chipset Model: Intel Iris 16:14:39 INFO - Type: GPU 16:14:39 INFO - Bus: Built-In 16:14:39 INFO - VRAM (Dynamic, Max): 1536 MB 16:14:39 INFO - Vendor: Intel (0x8086) 16:14:39 INFO - Device ID: 0x0a2e 16:14:39 INFO - Revision ID: 0x0009 16:14:39 INFO - Displays: 16:14:39 INFO - Display: 16:14:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:14:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:14:39 INFO - Display Serial Number: 1600x1200 60 16:14:39 INFO - Main Display: Yes 16:14:39 INFO - Mirror: Off 16:14:39 INFO - Online: Yes 16:14:39 INFO - Rotation: Supported 16:14:39 INFO - Return code: 0 16:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:14:39 INFO - Python 2.7.3 16:14:39 INFO - Return code: 0 16:14:39 INFO - grabbing minidump binary from tooltool 16:14:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103204d30>, '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 0x103028db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031fbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:14:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:14:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:14:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:14:39 INFO - Return code: 0 16:14:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:14:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:14:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:14:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:14:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:14:41 INFO - Return code: 0 16:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0072 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcMJ8FWzjR/Render', 16:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:41 INFO - 'HOME': '/Users/cltbld', 16:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:41 INFO - 'LOGNAME': 'cltbld', 16:14:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:14:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:41 INFO - 'MOZ_NO_REMOTE': '1', 16:14:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:14:41 INFO - 'NO_EM_RESTART': '1', 16:14:41 INFO - 'PAGER': '/bin/cat', 16:14:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:41 INFO - 'PWD': '/builds/slave/test', 16:14:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:41 INFO - 'SHELL': '/bin/bash', 16:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g2hI1nn215/Listeners', 16:14:41 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:41 INFO - 'USER': 'cltbld', 16:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:41 INFO - 'XPC_FLAGS': '0x0', 16:14:41 INFO - 'XPC_SERVICE_NAME': '0', 16:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:14:41 INFO - mozversion application_buildid: 20160218135626 16:14:41 INFO - mozversion application_changeset: cdc8bb2a48aec0970da93ba8d78cf11e851ed2bd 16:14:41 INFO - mozversion application_display_name: Nightly 16:14:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:14:41 INFO - mozversion application_name: Firefox 16:14:41 INFO - mozversion application_remotingname: firefox 16:14:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:14:41 INFO - mozversion application_vendor: Mozilla 16:14:41 INFO - mozversion application_version: 47.0a1 16:14:41 INFO - mozversion platform_buildid: 20160218135626 16:14:41 INFO - mozversion platform_changeset: cdc8bb2a48aec0970da93ba8d78cf11e851ed2bd 16:14:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:14:41 INFO - mozversion platform_version: 47.0a1 16:14:41 INFO - using testdate: 1455840881 16:14:41 INFO - actual date: 1455840881 16:14:41 INFO - starting webserver on 'localhost:49630' 16:14:41 INFO - SUITE-START | Running 2 tests 16:14:41 INFO - TEST-START | dromaeo_css 16:14:41 INFO - operating with platform_type : mac_ 16:14:41 INFO - Initialising browser for dromaeo_css test... 16:14:41 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpCJdLCQ/profile http://localhost:49630/getInfo.html) 16:14:44 INFO - PROCESS | 1971 | __metrics Screen width/height:1600/1200 16:14:44 INFO - PROCESS | 1971 | colorDepth:24 16:14:44 INFO - PROCESS | 1971 | Browser inner width/height: 1024/689 16:14:44 INFO - PROCESS | 1971 | __metrics 16:14:44 ERROR - PROCESS | 1971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 16:14:45 INFO - TEST-INFO | 1971: exit 0 16:14:45 INFO - Browser initialized. 16:14:45 INFO - Running cycle 1/1 for dromaeo_css test... 16:14:45 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpCJdLCQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:57 INFO - PROCESS | 1975 | RSS: Main: 257077248 16:14:57 INFO - PROCESS | 1975 | 16:15:46 INFO - PROCESS | 1975 | 1455840946862 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:17:57 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49630/tests/dromaeo/cssquery-ext.html) 16:17:58 INFO - PROCESS | 1975 | RSS: Main: 269385728 16:17:58 INFO - PROCESS | 1975 | 16:21:00 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-ext.html (next: http://localhost:49630/tests/dromaeo/cssquery-jquery.html) 16:21:01 INFO - PROCESS | 1975 | RSS: Main: 280756224 16:21:01 INFO - PROCESS | 1975 | 16:24:02 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49630/tests/dromaeo/cssquery-mootools.html) 16:24:03 INFO - PROCESS | 1975 | RSS: Main: 282472448 16:24:03 INFO - PROCESS | 1975 | 16:27:05 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49630/tests/dromaeo/cssquery-prototype.html) 16:27:05 INFO - PROCESS | 1975 | RSS: Main: 285499392 16:27:05 INFO - PROCESS | 1975 | 16:30:08 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49630/tests/dromaeo/cssquery-yui.html) 16:30:09 INFO - PROCESS | 1975 | RSS: Main: 288301056 16:30:09 INFO - PROCESS | 1975 | 16:33:11 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-yui.html (next: http://localhost:49630/tests/dromaeo/cssquery-dojo.html) 16:33:12 INFO - PROCESS | 1975 | RSS: Main: 289067008 16:33:12 INFO - PROCESS | 1975 | 16:33:12 INFO - PROCESS | 1975 | __start_tp_report 16:33:12 INFO - PROCESS | 1975 | _x_x_mozilla_page_load 16:33:12 INFO - PROCESS | 1975 | _x_x_mozilla_page_load_details 16:33:12 INFO - PROCESS | 1975 | |i|pagename|runs| 16:33:12 INFO - PROCESS | 1975 | |0;dojo.html;2932.882684692612;3545.3441113394024;3571.2678900825335;3586.121400256937;3588.4437912123612;5792.304923409197;5869.7652093916195;5889.322727886294;5889.646621202725;5924.43717846805;5842.415758424156;5844.912326315109;5854.151148083536;5890.793822216223;6072.635641861491;5203.635745497817;5262.657927234727;5396.055690254209;5503.871706300219;5523.25436066132;5191.766370513317;5355.651882627636;5402.243685883979;5437.510624043835;5451;5226.3989641191365;5310.99091172676;5327.520523152915;5360.303160589098;5383.192521121824;4790.616750659939;4999.9500004999845;5319.441458646825;5372.435894231088;5378.596605254583;5232.398274198478;5237.580993520509;5302.337207849019;5355.303810504648;5370.892582148335;4588.839390621312;5440.857419941817;5667.3482549506925;5722.62802917809;5740.741666625012;5258.842234732964;5729.567608097976;6221.191245138103;6237.34507876671;6243.094751261042;6118.20463339763;6203.2556093269095;6274.56078074535;6314.305426403092;6332.145160403333;5934.554908381889;6016.819495415145;6020.187274717945;6023;6073.210482637229;6199.938000620026;6297.874042519124;6313.779972214112;6376.1392212051705;6410.230772307353;6177.382261773877;6191.25704915413;6196.8760624787255;6212.689365531795;6220.782272620437;6261.499080073583;6267.749290028439;6270.372962703785;6273.372662733781;6283.874322513524;6082;6133.610107582658;6192.411720886508;6220.7511699532415;6259.655718935503;6181.598196117238;6214.8135555933395;6224.782132625427;6231.470325022424;6354.3645635437015;4872.80508779652;4959.479254678206;4974.228994505785;4988.975055124701;4994.700317980933;4422.71252368595;4436.977815110904;4450.643948484114;4479.283314669638;4526.275795872711;5392.595555333366;5788;5816.243888294494;5834.824955251349;5892.145638882338;6133.854967164949;6170.629762214281;6237.968810156011;6261.5616906816995;6268.435840774352;5792.4497172768515;5840.036393995028;5844.620099693507;5870;5874.324452687995;5482.671039737628;5491.862703432446;5503.587230957614;5506.834794956158;5522.30971128609;6263.3736626337;6336.651484168415;6403;6423.614583125028;6445.871082578416;4980.950190498049;6262.624242545462;6266.216722909637;6292.4966002720585;6293.402126797947;6271.655058971618;6384.233891932812;6447.323031081856;6464.933286007756;6503.934960650333;6185.536084793568;6199.597026193283;6201.379862013762;6214.875702485834;6230.252369715663;6190.2571691397325;6234.314225435108;6253.1245625613365;6287.371262873676;6356;5231.738413079407;6088.086786981811;6142.897836592492;6210.7515699371515;6228.875422491434;6139.324674285915;6195.1636529068;6201.751929922752;6210.5652604317265;6216.409441103088;5913.586048976703;6078.513718902565;6114.144019837316;6114.174586430775;6252;6119.929102025492;6220.066989951543;6221.222347206599;6224.439800417984;6243.656598887105;6058.939410605837;6090.482309003784;6132.540059495466;6133.662648554372;6143.078538219303 16:33:12 INFO - PROCESS | 1975 | |1;ext.html;456.936028955946;466.36108531312107;474.9026449577837;498.87777494513836;560.6383882395854;32023.039308820713;32996.84511042114;34236.486452703226;37640.247195056116;37752.43371349428;39208.60791392085;39785.40321895174;39791.60208397915;39795.40306895399;39865.40201896974;9303.162715355616;9441.150296473315;9462.479563623998;9486.66796662117;9502.429854208734;8500.74497765065;9651.80696386072;9654.5172741363;9655.13103820656;9663.130318271355;8824.911750882473;9617.615295388176;9634.75913102171;9638.903610963871;9701;9530.952345238264;9621.615135394575;9651;9664.130228279488;9666.468344241064;9461.148496635336;9560.521973901346;9565.617375304979;9586.76033099171;9627.951860240653;37719.811400943094;37845.6754013611;38059.429108563396;38132.42801357982;38219.04452388685;2775.7501824835863;3177.507486339621;3231.4344989626957;3256.0231930420778;3399.1162297802503;28257;28529.714702852914;28551.286217844514;28620.713792862014;28623.71376286252;2795.454886297173;2838.801283910127;2870.6555213374318;2883.3944871576996;2988.3126880817317;419823;421308;421532;500882;543433;58334.958276460966;59141;59430.40569594335;60156.699216504516;60245;62644.686776565824;62915;62997.370026300065;63156.68421657862;63494.68252658707;15894.284757185955;16439.506814795575;16460.4238851642;16595.17024148788;16668.08325542107;12763.744725105445;12856.164349317265;12935.676608084685;12957.416916238602;12979.41592628315;19667.016649167483;19707.901460492893;19742.11160497781;19842.900785495982;19890.403287901387;8378.120297368689;8506.31949444043;8520.69589672246;8548.74353769388;8551.871721924175;926.536731634183;957.7366224288377;971.8785151856018;1022.831232846572;1040.2354269611828;29330.85334573356;29762.40475190484;29889.402211956072;29924.102276931728;30379.684125002197;1032.7831155457288;1036.7719101797743;1038.48075962019;1054.8839627640953;1081.4430568257353;13305.334733263298;14668.339924703414;14698;14821.258937053104;15006.549803505912;558904;563290;568193;572010;578284;55441;55765;56051.43948560462;56742.43257567454;56751.864962701344;1409.0840953380384;1409.605310513058;1412.0892024644047;1425.415579612354;1425.9429622815178;28883;28905.4897675049;28971.710282897744;29533.26166845846;29537.26156846096;45351.546484536055;45661.54338456573;45828.541714582425;51484;51713.44859654216;514112;518093;520761;523077;524598;25877.482450351265;30674.386512270077;31947.36105277835;33214;33469;35678.10804729799;38398.80800595979;40442.79778601088;41435.96410089772;41598.58401416068;34035.638574456745;34386.656133438344;35091.298174036885;35267.82366088153;36603.63396366109;33598.83200583982;33924.15189620279;34749.305013900084;34753.957381278604;35444.759433419706;35451.468227977115;35723.46414803728;35887.64112358948;36665.45001825028;37055.62944370522;29368.412631747673;30849.845750771103;30956.0713178605;30978.69021309758;31124.844375777975;18565.35021274249;22997.770022299563;23879.52240955206;23944.40138996539;23953.281401557982 16:33:12 INFO - PROCESS | 1975 | |2;jquery.html;310.6536212123483;360.33697995687936;360.59433137720066;366.68465119996796;372.3669761405611;15394.923025384858;15866.524004279876;19200.90399548002;19630.705539416886;20461.590768184647;11788.351640659761;12078.214916030453;12237.632871013884;12259;19866.801331986677;5120.540645915906;5200.869978250536;5371.838844834661;5380.381256155533;5397.568194544447;5170.848506010882;5171.198464238049;5208.791648334062;5281.36623605166;5325.094733895247;3903.1998440319667;5351.57187425005;5352.2506849041165;5358.490943360394;5580.888382232353;4896.290037944514;5774.855628609276;5778.451047150556;5809.419058094199;5812.6512409255365;5344.759485823147;5566.2207290979295;5620.971895140498;5650.180723795027;5656.745446454919;11009.669709908716;18247.270109195615;19265.036748162536;23169.76830231693;23848.64227036596;1941.4078705994666;1997.8201961823506;2021.6462119129094;2049.6515592349338;2061.8762874227596;13338.466461341535;14163.079399838978;14183.716325673531;14370.640733981734;14681.632959175999;1735.0197138616768;1752.7984281807628;1761.9911900440416;1804.4225847728733;1834.2937968882077;95912.52043739807;101423;103094.45358319631;104380;105930.47034764854;10906.890931090746;11471.655850324503;11487.54049837997;11608.678264346996;11620.012298954514;10890.891091088988;11519.769604607862;11908.583199587973;13640.795388069188;13709.383077761326;7941.444098913021;8281.337493000545;8575.228229459379;8640.870386944202;8655.091215422415;8642.308615310885;8725.52009639476;8770.561471926378;8778.166074222938;8809.075047120088;3702.426123950792;4422.137683151755;4485.820567177341;4503.54964503547;4535.954640453553;1668.2076013893304;1872.4850666066668;1890.4423195157462;1897.127321432129;1912.5792325688606;434.10790824855223;439.6087482140897;802.530519646002;878.8462019146624;892.4377642085444;11618.302901825917;11773.52905883755;11890.346030968207;11934.940325298317;12048.638540843789;440.65408654206936;448.52904450327026;455.5876931377109;464.6538328944958;471.82542459290283;6014.51883849291;6074.149619053336;6172.444479996821;6173.938260617426;6184.103305020747;524904;536829;536888;624161;627984;74656.62671686607;77298.20263480261;84115;119722.4013879925;128697;999.8400255959157;1031.046282188972;1048.5438834107188;1049.1292227451197;1057.6615483045505;17747.733783992993;17998;18270.543236418664;18642.34751783681;18694.719579206052;35714.749983750444;49563.75218124031;50104.74947625384;51002.74498627483;51678.48321516737;67248;71191;71538;72107.63946180236;73735.52528949498;7790.88313675284;7866;7866.292033716764;7980.960095199719;8010.759677209693;10006.69979900604;11447.626284845872;12303.753924921273;12457.314847683101;12719.618411447671;9467.479288639192;10002.799944001225;10093.646722364681;10761.73095672583;10994.560217591526;4959.760059985004;9672.516374181403;10701.090407315465;10913.508892100033;11054.723631909266;11205.215634905479;11262.436878155895;11380.94309528447;11521.481533330852;11644.475998579916;7117.8932316016335;7507.249275072449;7844.372450204084;7903.486273392211;7926.603669816602;9933.712168374208;10474.214433917334;11026.669199924016;11080.778384432106;11096.778064438828 16:33:12 INFO - PROCESS | 1975 | |3;mootools.html;1496.4463148635004;1510.9951881998472;1728.6024214430681;1870.1677753399742;1875.8030406807277;7727.150013498511;8273.75178744638;8319.792005199874;8481.618327175276;8496.022957359914;7149.85700285994;7421.962890185555;8186.8538404623405;8440.535770532619;8590.95704521478;2461.4215659320043;2476.5913624252066;2490.9003639854386;2492.4516606346574;2494.713107992577;2434.926952191437;2463.051725085846;2463.408781892351;2483.8758062096913;2498.387894965727;2161.9351419457444;2349.2717257650097;2351.47091904321;2370.360002799252;2447.877606119687;2454.7667971542764;2472.666190064336;2491.9750802491926;2493.376655836041;2498.650188973545;2458.864762438065;2473.8639374834556;2478.8388754731063;2483.52812965536;2491.0907518755703;7508.9487471754;8085.919140808575;8483.915160848373;8505.787355316166;8510.659573617047;5233.110371236899;5331.733413329318;5402.486763757437;5416.268803711528;5438.102713052342;3521.559805024372;3573.4997100405963;3649.033006253345;3666.2300916807503;3666.944995825065;1059.9470026498643;1073.2111897755144;1076.8169411200115;1103.365564800235;1103.9116870650328;11643.952044316053;11678.124140689482;11696.415179241088;11707.76584468306;11724.472398741991;4779;4797.832075877328;4825.782839772149;4833.32333473314;4865.489123642037;9925.255605829592;9967.950160249153;9970.700878973643;9973.401595904268;10004.049615286536;5390.51485366319;5391.191321301836;5409.080456322435;5428.647137936022;5429.972850135724;4903.387076615423;4913.410390753133;4946.703197808143;4966.106100901872;4966.528179822911;3941.625545573166;3973.7482692951626;3981.900452488711;3986.60133986599;3995.081131339808;1309.6594885329691;1313.2711345203313;1317.9934100329629;1319.0502837956847;1328.4154971812372;944.6410364061612;1101.3942331717524;1141.395060617874;1235.4131787401093;1365.378752667534;7761.146273909865;7767.766966990999;7776.183500732342;7787.493812902257;7900.841983160304;1172.0916289875415;1177.4407156600716;1181.173178774861;1181.6750393641646;1189.2210602055495;4766.189747742892;6080.422359875804;6108.572399932051;6169.167162433014;6207.317195108534;9197.264218862474;10447.955204479491;10538.789224215472;10578.153747700166;10587.629432969808;10279.383237005653;10402.739931501774;10421.583136674448;10451.895481045245;10551.15590752738;8018.238267364591;8202.917970820336;8207.548584827891;8219.917800822035;8277.04813946392;7697.422693298137;7703.845923081619;7725.343345815669;7742.070951485858;7758.883616745867;9164.541772911194;9368.765780855532;9435.292353073684;9484.099010593982;9489.620415183315;9339.112784285482;9755.073268039525;9755.951220243853;9844.606215751577;9903.257255705706;7360.96319518399;7401.888971665537;7426.851462970602;7440.107187137578;7442.255774422514;7988.520688758693;8080.949476568244;8081.313088387553;8098.271155595789;8156.592170391338;6401.967990160019;7321.267873212636;7343.632818359168;7454.142773580891;7505.737299194502;6368.395002474757;7105.680244388912;7106.4314854810455;7127.861641507423;7206.2793720627515;6389.840253993687;7497.587632680255;7571.545707257582;7573.545587264562;7576.2423757626;6932.826679333057;6975.686094125675;6979.9181126925405;6981.197162326397;6984.860302794017;6939.548929319578;7091.539049961736;7095.432365410858;7097.751578694721;7098.787036388917 16:33:12 INFO - PROCESS | 1975 | |4;prototype.html;281.56779343707404;331.8805230117156;333.4681183512297;338.9186595217148;344.24438357804627;6695.129633147684;6821.079154314172;6827.453803695705;6834.282400347966;6849.486288528368;6891.345322194396;6925.619090950008;6929.549579277344;6942.965285173567;6945.270746571613;5099.337086178792;5123.975204959004;5144.022635699224;5150;5181.1969144782615;3896.7530390275124;5125.641205115643;5134.64057515974;5140.511651393112;5151.124308867502;4939.753012349386;4950.529699678525;4955.306257124005;4964.826231081913;4979.751012449363;4931.926021109686;4946.134426475388;4961.206207006861;4977.427595826472;4981.27771473138;4219.409282700424;4226.1336426032585;4226.323788193905;4230.894227644303;4236.788160591958;6293.716782744787;6504.536479292122;6528.151340325775;6556.114924485181;6592.241892182413;5791.88416231673;5794.797182098607;5802.448767367094;5808.4191580842;5823.272090988627;7329.497453022171;7333.303336183054;7341.192468828424;7348.816279592999;7362.300581444754;4445.444319460067;4523.525029871849;4609;4647.302904564309;4659.347691323217;6063.333033366326;6822.976553517012;7170.39051680613;7458.142313633947;7725.922740772577;3802.16352402471;3949.940750888739;4030.7581545107387;4321.157374311979;4690.319903613957;4401.1417773534495;4588.770561471913;4767.332573439721;4821.7589120543835;4828.66199366048;5687.345955215121;5692.430756924357;5713.314402271671;5732.455416735404;5753.280839895013;6064.727087281083;7239.131304243525;7305.634718264172;7305.707771689073;7310;1674.0541593999594;1699.2947926610318;1700.1924086059023;1703.3612395351743;1707.675541647083;1034.846146546595;1049.2393015064017;1058.915286777056;1072.7371793910543;1093.0818112785298;6787.490938179656;6815.795526134224;6833.863322733518;6836.658167091626;6843.3840954314355;7590.1650818409935;7607.695692172251;7612.1246056703085;7612.885806712793;7627.351675107567;6630.701618427182;6765.9661701691175;6800.08198893153;6871.278515755874;6897.1033765611155;4014.197160567898;4042.292598795199;4058.4723985882238;4074.8777536673947;4077;8059.919400806034;8061.717839875576;8086.7169649062;8100.392470564731;8124.7562573122905;7646.4265180111715;7967.521948683097;7969.880451793228;7974.4417890748255;7991.800204994922;8030.799230019296;8040.8793868092025;8043.7586872395095;8070.2333278338465;8070.273675369245;7029.578225306498;7657.655405506877;7690.2694244046725;7691.807704807425;7696.307332340116;7506.24937506245;7522.962385188039;7545.811354716176;7546.735864244725;7558.014584239085;6297.779577714758;7653.617319134132;8041.798955025937;8059.904424849464;8074.192580741878;4596.264597664358;4760.119377915097;4781.402324709411;4783.402074740658;4801.471838097877;6269.467095296768;7573.507721998052;7653.464257501922;7662.463627546018;7663.655135518804;7343.118825740945;7351.264873512606;7352;7354.595497247703;7376.004239427823;7152.284771523015;7393.667284972082;7457.664405101892;7464.216257292906;7472.589007604634;7242.746503872339;7243.7464688735645;7252.5648461092505;7272;7298;7218.927810722035;7423.183449820407;7427.480076394817;7435.367993720594;7435.851282974419;6232.875342493034;7058.6470676467;7251.746188883364;7263.818404539928;7268.382187513909 16:33:12 INFO - PROCESS | 1975 | |5;yui.html;647.1683886206223;673.7069374821956;678.4707927816304;692.5360008794107;706.9045678833356;13142.817146456817;14768.784682297648;14927.477538286163;14946.02850814699;14955.925220373896;12063.51745930164;13611.319434028308;13621.727565448686;14576;15201.087934723924;864.0107077396377;878.0078511282258;891.4918496457022;893.5041052216018;893.9910600894005;674.7739507265072;783.3772151139829;871.7428358634187;891.4606662968907;892.6340200517789;920.4523308631353;937.4750139921666;941.6092321686492;943.528235882059;944.5796620503878;904.3759805734055;910.4582773249906;923.2890674180843;928.8885333759993;931.3061768982118;658.5982550644103;666.4601672645173;694.3056943056943;700.7757517594372;703.1737708192904;14231.146131232159;14249.145051296955;14276;14328.64178395538;14345.569632910925;12424.937875310565;12498.437570309357;12554.999999999909;12683.556075537312;12877.742445151045;9988.650397236062;9995.75010624733;10239.436830974293;10393;10766.730831729192;3460.3944309745693;3593;3593.586737525192;3649.6350364963555;3659.634036596319;65450.67274663596;75280.62359688221;83303.5834820822;84376;85667;8702.216800487986;9397.57710903011;9475.241980641533;9603.231741460666;9658.179054780281;20383.8980805095;20384.184632614826;20395.8980205098;20423.285185018452;20437.795622043886;7354;7495.700171993169;7550.35821955129;7623.275788800166;7632.732854350071;4116.320807066861;4134.441850350164;4143.19207754485;4180.101278225196;4185.183889141649;3458.152752575635;3479.251960828434;3485.233248685285;3492.406290930548;3502.9299414012085;627.0500192208807;634.1344065350763;637.2448648351718;656.6847913001786;657.7697805767943;458.9701669391546;534.8447353715954;544.7848100000477;582.7814569536424;597.1103056445864;8703.43427677199;8984.101589841095;9064.274858011475;9108.362414630912;9218.170364667212;591.2343515147894;602.9517638588902;618.7679620142446;622.2253294648192;635.8505751148476;4201.609318262423;4268.573142685706;4295.312749959991;4337.7180483268485;4399.428074350314;95028.57457138148;95559;95829;96713.51643241738;100709;75992;83579.91050223794;83981.58009210037;85445;89440.55279723559;54435;63275;70714.29285707077;71797.6410117946;77202.84195737068;7726.729564465217;8743.169398907094;8796.856408666832;8954.955225223832;9060.946482974448;51126.97746045133;53100.406987790426;53190.73404632952;53241.93516129733;53942;64573;65225;68508.62982740418;73404;74821;11409.771804564029;11550.537978480766;12000.63998080059;12259.938700306442;12449.813252801034;12263.448144833326;12288.569900053455;12337.691557711129;12453.377331133588;12526;11826.053915686896;11847.881521185023;11999.460024298753;12097.334646594521;12104.636860894187;10323.741906452398;11812.409379530816;11856.822147667619;12022.33877136731;12087.818682719942;8873.467591944504;10875.129989600971;11386.772264554496;11506.30962142274;11696.824547631622;8760.299176066026;9828.16460600857;9959.850602241117;10006.749831253986;10237.181025517792;9846.950765246127;10013.24900632441;10103.191744660557;10151.441670708182;10160.847587286344 16:33:12 INFO - PROCESS | 1975 | __end_tp_report 16:33:12 INFO - PROCESS | 1975 | __start_cc_report 16:33:12 INFO - PROCESS | 1975 | _x_x_mozilla_cycle_collect,354 16:33:12 INFO - PROCESS | 1975 | __end_cc_report 16:33:12 INFO - PROCESS | 1975 | __startTimestamp1455841992018__endTimestamp 16:33:12 INFO - PROCESS | 1975 | 16:33:12 INFO - PROCESS | 1975 | ------- Summary: start ------- 16:33:12 INFO - PROCESS | 1975 | Number of tests: 6 16:33:12 INFO - PROCESS | 1975 | 16:33:12 INFO - PROCESS | 1975 | [#0] dojo.html Cycles:165 Average:5793.64 Median:6082.00 stddev:644.66 (10.6%) stddev-sans-first:606.32 16:33:12 INFO - PROCESS | 1975 | Values: 2932.9 3545.3 3571.3 3586.1 3588.4 5792.3 5869.8 5889.3 5889.6 5924.4 5842.4 5844.9 5854.2 5890.8 6072.6 5203.6 5262.7 5396.1 5503.9 5523.3 5191.8 5355.7 5402.2 5437.5 5451.0 5226.4 5311.0 5327.5 5360.3 5383.2 4790.6 5000.0 5319.4 5372.4 5378.6 5232.4 5237.6 5302.3 5355.3 5370.9 4588.8 5440.9 5667.3 5722.6 5740.7 5258.8 5729.6 6221.2 6237.3 6243.1 6118.2 6203.3 6274.6 6314.3 6332.1 5934.6 6016.8 6020.2 6023.0 6073.2 6199.9 6297.9 6313.8 6376.1 6410.2 6177.4 6191.3 6196.9 6212.7 6220.8 6261.5 6267.7 6270.4 6273.4 6283.9 6082.0 6133.6 6192.4 6220.8 6259.7 6181.6 6214.8 6224.8 6231.5 6354.4 4872.8 4959.5 4974.2 4989.0 4994.7 4422.7 4437.0 4450.6 4479.3 4526.3 5392.6 5788.0 5816.2 5834.8 5892.1 6133.9 6170.6 6238.0 6261.6 6268.4 5792.4 5840.0 5844.6 5870.0 5874.3 5482.7 5491.9 5503.6 5506.8 5522.3 6263.4 6336.7 6403.0 6423.6 6445.9 4981.0 6262.6 6266.2 6292.5 6293.4 6271.7 6384.2 6447.3 6464.9 6503.9 6185.5 6199.6 6201.4 6214.9 6230.3 6190.3 6234.3 6253.1 6287.4 6356.0 5231.7 6088.1 6142.9 6210.8 6228.9 6139.3 6195.2 6201.8 6210.6 6216.4 5913.6 6078.5 6114.1 6114.2 6252.0 6119.9 6220.1 6221.2 6224.4 6243.7 6058.9 6090.5 6132.5 6133.7 6143.1 16:33:12 INFO - PROCESS | 1975 | 16:33:12 INFO - PROCESS | 1975 | [#1] ext.html Cycles:180 Average:64879.85 Median:37347.94 stddev:138472.10 (370.8%) stddev-sans-first:138776.07 16:33:12 INFO - PROCESS | 1975 | Values: 456.9 466.4 474.9 498.9 560.6 32023.0 32996.8 34236.5 37640.2 37752.4 39208.6 39785.4 39791.6 39795.4 39865.4 9303.2 9441.2 9462.5 9486.7 9502.4 8500.7 9651.8 9654.5 9655.1 9663.1 8824.9 9617.6 9634.8 9638.9 9701.0 9531.0 9621.6 9651.0 9664.1 9666.5 9461.1 9560.5 9565.6 9586.8 9628.0 37719.8 37845.7 38059.4 38132.4 38219.0 2775.8 3177.5 3231.4 3256.0 3399.1 28257.0 28529.7 28551.3 28620.7 28623.7 2795.5 2838.8 2870.7 2883.4 2988.3 419823.0 421308.0 421532.0 500882.0 543433.0 58335.0 59141.0 59430.4 60156.7 60245.0 62644.7 62915.0 62997.4 63156.7 63494.7 15894.3 16439.5 16460.4 16595.2 16668.1 12763.7 12856.2 12935.7 12957.4 12979.4 19667.0 19707.9 19742.1 19842.9 19890.4 8378.1 8506.3 8520.7 8548.7 8551.9 926.5 957.7 971.9 1022.8 1040.2 29330.9 29762.4 29889.4 29924.1 30379.7 1032.8 1036.8 1038.5 1054.9 1081.4 13305.3 14668.3 14698.0 14821.3 15006.5 558904.0 563290.0 568193.0 572010.0 578284.0 55441.0 55765.0 56051.4 56742.4 56751.9 1409.1 1409.6 1412.1 1425.4 1425.9 28883.0 28905.5 28971.7 29533.3 29537.3 45351.5 45661.5 45828.5 51484.0 51713.4 514112.0 518093.0 520761.0 523077.0 524598.0 25877.5 30674.4 31947.4 33214.0 33469.0 35678.1 38398.8 40442.8 41436.0 41598.6 34035.6 34386.7 35091.3 35267.8 36603.6 33598.8 33924.2 34749.3 34754.0 35444.8 35451.5 35723.5 35887.6 36665.5 37055.6 29368.4 30849.8 30956.1 30978.7 31124.8 18565.4 22997.8 23879.5 23944.4 23953.3 16:33:12 INFO - PROCESS | 1975 | 16:33:12 INFO - PROCESS | 1975 | [#2] jquery.html Cycles:180 Average:31629.92 Median:2034.56 stddev:94813.32 (4660.1%) stddev-sans-first:95050.13 16:33:12 INFO - PROCESS | 1975 | Values: 310.7 360.3 360.6 366.7 372.4 15394.9 15866.5 19200.9 19630.7 20461.6 11788.4 12078.2 12237.6 12259.0 19866.8 5120.5 5200.9 5371.8 5380.4 5397.6 5170.8 5171.2 5208.8 5281.4 5325.1 3903.2 5351.6 5352.3 5358.5 5580.9 4896.3 5774.9 5778.5 5809.4 5812.7 5344.8 5566.2 5621.0 5650.2 5656.7 11009.7 18247.3 19265.0 23169.8 23848.6 1941.4 1997.8 2021.6 2049.7 2061.9 13338.5 14163.1 14183.7 14370.6 14681.6 1735.0 1752.8 1762.0 1804.4 1834.3 95912.5 101423.0 103094.5 104380.0 105930.5 10906.9 11471.7 11487.5 11608.7 11620.0 10890.9 11519.8 11908.6 13640.8 13709.4 7941.4 8281.3 8575.2 8640.9 8655.1 8642.3 8725.5 8770.6 8778.2 8809.1 3702.4 4422.1 4485.8 4503.5 4536.0 1668.2 1872.5 1890.4 1897.1 1912.6 434.1 439.6 802.5 878.8 892.4 11618.3 11773.5 11890.3 11934.9 12048.6 440.7 448.5 455.6 464.7 471.8 6014.5 6074.1 6172.4 6173.9 6184.1 524904.0 536829.0 536888.0 624161.0 627984.0 74656.6 77298.2 84115.0 119722.4 128697.0 999.8 1031.0 1048.5 1049.1 1057.7 17747.7 17998.0 18270.5 18642.3 18694.7 35714.7 49563.8 50104.7 51002.7 51678.5 67248.0 71191.0 71538.0 72107.6 73735.5 7790.9 7866.0 7866.3 7981.0 8010.8 10006.7 11447.6 12303.8 12457.3 12719.6 9467.5 10002.8 10093.6 10761.7 10994.6 4959.8 9672.5 10701.1 10913.5 11054.7 11205.2 11262.4 11380.9 11521.5 11644.5 7117.9 7507.2 7844.4 7903.5 7926.6 9933.7 10474.2 11026.7 11080.8 11096.8 16:33:12 INFO - PROCESS | 1975 | 16:33:12 INFO - PROCESS | 1975 | [#3] mootools.html Cycles:180 Average:5925.54 Median:5412.67 stddev:3071.04 (56.7%) stddev-sans-first:3061.61 16:33:12 INFO - PROCESS | 1975 | Values: 1496.4 1511.0 1728.6 1870.2 1875.8 7727.2 8273.8 8319.8 8481.6 8496.0 7149.9 7422.0 8186.9 8440.5 8591.0 2461.4 2476.6 2490.9 2492.5 2494.7 2434.9 2463.1 2463.4 2483.9 2498.4 2161.9 2349.3 2351.5 2370.4 2447.9 2454.8 2472.7 2492.0 2493.4 2498.7 2458.9 2473.9 2478.8 2483.5 2491.1 7508.9 8085.9 8483.9 8505.8 8510.7 5233.1 5331.7 5402.5 5416.3 5438.1 3521.6 3573.5 3649.0 3666.2 3666.9 1059.9 1073.2 1076.8 1103.4 1103.9 11644.0 11678.1 11696.4 11707.8 11724.5 4779.0 4797.8 4825.8 4833.3 4865.5 9925.3 9968.0 9970.7 9973.4 10004.0 5390.5 5391.2 5409.1 5428.6 5430.0 4903.4 4913.4 4946.7 4966.1 4966.5 3941.6 3973.7 3981.9 3986.6 3995.1 1309.7 1313.3 1318.0 1319.1 1328.4 944.6 1101.4 1141.4 1235.4 1365.4 7761.1 7767.8 7776.2 7787.5 7900.8 1172.1 1177.4 1181.2 1181.7 1189.2 4766.2 6080.4 6108.6 6169.2 6207.3 9197.3 10448.0 10538.8 10578.2 10587.6 10279.4 10402.7 10421.6 10451.9 10551.2 8018.2 8202.9 8207.5 8219.9 8277.0 7697.4 7703.8 7725.3 7742.1 7758.9 9164.5 9368.8 9435.3 9484.1 9489.6 9339.1 9755.1 9756.0 9844.6 9903.3 7361.0 7401.9 7426.9 7440.1 7442.3 7988.5 8080.9 8081.3 8098.3 8156.6 6402.0 7321.3 7343.6 7454.1 7505.7 6368.4 7105.7 7106.4 7127.9 7206.3 6389.8 7497.6 7571.5 7573.5 7576.2 6932.8 6975.7 6979.9 6981.2 6984.9 6939.5 7091.5 7095.4 7097.8 7098.8 16:33:12 INFO - PROCESS | 1975 | 16:33:12 INFO - PROCESS | 1975 | [#4] prototype.html Cycles:180 Average:5956.12 Median:6818.44 stddev:1952.03 (28.6%) stddev-sans-first:1910.48 16:33:12 INFO - PROCESS | 1975 | Values: 281.6 331.9 333.5 338.9 344.2 6695.1 6821.1 6827.5 6834.3 6849.5 6891.3 6925.6 6929.5 6943.0 6945.3 5099.3 5124.0 5144.0 5150.0 5181.2 3896.8 5125.6 5134.6 5140.5 5151.1 4939.8 4950.5 4955.3 4964.8 4979.8 4931.9 4946.1 4961.2 4977.4 4981.3 4219.4 4226.1 4226.3 4230.9 4236.8 6293.7 6504.5 6528.2 6556.1 6592.2 5791.9 5794.8 5802.4 5808.4 5823.3 7329.5 7333.3 7341.2 7348.8 7362.3 4445.4 4523.5 4609.0 4647.3 4659.3 6063.3 6823.0 7170.4 7458.1 7725.9 3802.2 3949.9 4030.8 4321.2 4690.3 4401.1 4588.8 4767.3 4821.8 4828.7 5687.3 5692.4 5713.3 5732.5 5753.3 6064.7 7239.1 7305.6 7305.7 7310.0 1674.1 1699.3 1700.2 1703.4 1707.7 1034.8 1049.2 1058.9 1072.7 1093.1 6787.5 6815.8 6833.9 6836.7 6843.4 7590.2 7607.7 7612.1 7612.9 7627.4 6630.7 6766.0 6800.1 6871.3 6897.1 4014.2 4042.3 4058.5 4074.9 4077.0 8059.9 8061.7 8086.7 8100.4 8124.8 7646.4 7967.5 7969.9 7974.4 7991.8 8030.8 8040.9 8043.8 8070.2 8070.3 7029.6 7657.7 7690.3 7691.8 7696.3 7506.2 7523.0 7545.8 7546.7 7558.0 6297.8 7653.6 8041.8 8059.9 8074.2 4596.3 4760.1 4781.4 4783.4 4801.5 6269.5 7573.5 7653.5 7662.5 7663.7 7343.1 7351.3 7352.0 7354.6 7376.0 7152.3 7393.7 7457.7 7464.2 7472.6 7242.7 7243.7 7252.6 7272.0 7298.0 7218.9 7423.2 7427.5 7435.4 7435.9 6232.9 7058.6 7251.7 7263.8 7268.4 16:33:12 INFO - PROCESS | 1975 | 16:33:12 INFO - PROCESS | 1975 | [#5] yui.html Cycles:180 Average:18620.38 Median:600.03 stddev:26406.91 (4400.9%) stddev-sans-first:26446.50 16:33:12 INFO - PROCESS | 1975 | Values: 647.2 673.7 678.5 692.5 706.9 13142.8 14768.8 14927.5 14946.0 14955.9 12063.5 13611.3 13621.7 14576.0 15201.1 864.0 878.0 891.5 893.5 894.0 674.8 783.4 871.7 891.5 892.6 920.5 937.5 941.6 943.5 944.6 904.4 910.5 923.3 928.9 931.3 658.6 666.5 694.3 700.8 703.2 14231.1 14249.1 14276.0 14328.6 14345.6 12424.9 12498.4 12555.0 12683.6 12877.7 9988.7 9995.8 10239.4 10393.0 10766.7 3460.4 3593.0 3593.6 3649.6 3659.6 65450.7 75280.6 83303.6 84376.0 85667.0 8702.2 9397.6 9475.2 9603.2 9658.2 20383.9 20384.2 20395.9 20423.3 20437.8 7354.0 7495.7 7550.4 7623.3 7632.7 4116.3 4134.4 4143.2 4180.1 4185.2 3458.2 3479.3 3485.2 3492.4 3502.9 627.1 634.1 637.2 656.7 657.8 459.0 534.8 544.8 582.8 597.1 8703.4 8984.1 9064.3 9108.4 9218.2 591.2 603.0 618.8 622.2 635.9 4201.6 4268.6 4295.3 4337.7 4399.4 95028.6 95559.0 95829.0 96713.5 100709.0 75992.0 83579.9 83981.6 85445.0 89440.6 54435.0 63275.0 70714.3 71797.6 77202.8 7726.7 8743.2 8796.9 8955.0 9060.9 51127.0 53100.4 53190.7 53241.9 53942.0 64573.0 65225.0 68508.6 73404.0 74821.0 11409.8 11550.5 12000.6 12259.9 12449.8 12263.4 12288.6 12337.7 12453.4 12526.0 11826.1 11847.9 11999.5 12097.3 12104.6 10323.7 11812.4 11856.8 12022.3 12087.8 8873.5 10875.1 11386.8 11506.3 11696.8 8760.3 9828.2 9959.9 10006.7 10237.2 9847.0 10013.2 10103.2 10151.4 10160.8 16:33:12 INFO - PROCESS | 1975 | -------- Summary: end -------- 16:33:12 INFO - PROCESS | 1975 | 16:33:12 INFO - TEST-INFO | 1975: exit 0 16:33:12 INFO - TEST-OK | dromaeo_css | took 1110810ms 16:33:12 INFO - TEST-START | kraken 16:33:12 INFO - operating with platform_type : mac_ 16:33:12 INFO - Initialising browser for kraken test... 16:33:12 INFO - TEST-INFO | started process 1982 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpBveUYY/profile http://localhost:49630/getInfo.html) 16:33:15 INFO - PROCESS | 1982 | __metrics Screen width/height:1600/1200 16:33:15 INFO - PROCESS | 1982 | colorDepth:24 16:33:15 INFO - PROCESS | 1982 | Browser inner width/height: 1024/689 16:33:15 INFO - PROCESS | 1982 | __metrics 16:33:15 ERROR - PROCESS | 1982 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 16:33:15 INFO - TEST-INFO | 1982: exit 0 16:33:15 INFO - Browser initialized. 16:33:15 INFO - Running cycle 1/1 for kraken test... 16:33:15 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpBveUYY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:27 INFO - PROCESS | 1985 | RSS: Main: 255418368 16:33:27 INFO - PROCESS | 1985 | 16:33:30 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49630/tests/kraken/driver.html?testName=audio-beat-detection) 16:33:31 INFO - PROCESS | 1985 | RSS: Main: 267776000 16:33:31 INFO - PROCESS | 1985 | 16:33:34 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49630/tests/kraken/driver.html?testName=audio-dft) 16:33:34 INFO - PROCESS | 1985 | RSS: Main: 276525056 16:33:34 INFO - PROCESS | 1985 | 16:33:38 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49630/tests/kraken/driver.html?testName=audio-fft) 16:33:38 INFO - PROCESS | 1985 | RSS: Main: 280289280 16:33:38 INFO - PROCESS | 1985 | 16:33:40 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49630/tests/kraken/driver.html?testName=audio-oscillator) 16:33:41 INFO - PROCESS | 1985 | RSS: Main: 282300416 16:33:41 INFO - PROCESS | 1985 | 16:33:43 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49630/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:33:43 INFO - PROCESS | 1985 | RSS: Main: 282730496 16:33:43 INFO - PROCESS | 1985 | 16:33:46 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49630/tests/kraken/driver.html?testName=imaging-darkroom) 16:33:47 INFO - PROCESS | 1985 | RSS: Main: 282087424 16:33:47 INFO - PROCESS | 1985 | 16:33:49 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49630/tests/kraken/driver.html?testName=imaging-desaturate) 16:33:50 INFO - PROCESS | 1985 | RSS: Main: 283140096 16:33:50 INFO - PROCESS | 1985 | 16:33:53 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49630/tests/kraken/driver.html?testName=json-parse-financial) 16:33:54 INFO - PROCESS | 1985 | RSS: Main: 283656192 16:33:54 INFO - PROCESS | 1985 | 16:33:55 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49630/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:33:56 INFO - PROCESS | 1985 | RSS: Main: 284336128 16:33:56 INFO - PROCESS | 1985 | 16:33:58 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:33:58 INFO - PROCESS | 1985 | RSS: Main: 283963392 16:33:58 INFO - PROCESS | 1985 | 16:34:00 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:34:01 INFO - PROCESS | 1985 | RSS: Main: 284254208 16:34:01 INFO - PROCESS | 1985 | 16:34:03 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:34:04 INFO - PROCESS | 1985 | RSS: Main: 284241920 16:34:04 INFO - PROCESS | 1985 | 16:34:07 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:34:07 INFO - PROCESS | 1985 | RSS: Main: 284233728 16:34:07 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49630/tests/kraken/driver.html?testName=ai-astar) 16:34:09 INFO - PROCESS | 1985 | RSS: Main: 284524544 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | __start_tp_report 16:34:09 INFO - PROCESS | 1985 | _x_x_mozilla_page_load 16:34:09 INFO - PROCESS | 1985 | _x_x_mozilla_page_load_details 16:34:09 INFO - PROCESS | 1985 | |i|pagename|runs| 16:34:09 INFO - PROCESS | 1985 | |0;ai-astar;113;105;132;165;160;123;117;166;113;114 16:34:09 INFO - PROCESS | 1985 | |1;audio-beat-detection;189;146;145;170;156;174;161;119;157;121 16:34:09 INFO - PROCESS | 1985 | |2;audio-dft;192;202;197;215;272;252;197;198;199;195 16:34:09 INFO - PROCESS | 1985 | |3;audio-fft;79;61;71;132;49;61;91;88;63;70 16:34:09 INFO - PROCESS | 1985 | |4;audio-oscillator;87;85;119;80;82;81;116;80;80;113 16:34:09 INFO - PROCESS | 1985 | |5;imaging-gaussian-blur;88;84;126;92;86;90;86;93;86;103 16:34:09 INFO - PROCESS | 1985 | |6;imaging-darkroom;94;95;93;95;97;94;95;96;94;94 16:34:09 INFO - PROCESS | 1985 | |7;imaging-desaturate;93;94;92;93;114;126;100;90;145;148 16:34:09 INFO - PROCESS | 1985 | |8;json-parse-financial;54;57;55;55;56;55;55;61;55;55 16:34:09 INFO - PROCESS | 1985 | |9;json-stringify-tinderbox;62;66;64;70;81;75;68;66;73;61 16:34:09 INFO - PROCESS | 1985 | |10;stanford-crypto-aes;87;85;87;84;85;84;85;90;85;84 16:34:09 INFO - PROCESS | 1985 | |11;stanford-crypto-ccm;130;126;127;126;123;130;126;143;139;112 16:34:09 INFO - PROCESS | 1985 | |12;stanford-crypto-pbkdf2;146;188;183;143;148;137;135;127;187;124 16:34:09 INFO - PROCESS | 1985 | |13;stanford-crypto-sha256-iterative;70;67;69;68;71;70;66;68;69;68 16:34:09 INFO - PROCESS | 1985 | __end_tp_report 16:34:09 INFO - PROCESS | 1985 | __start_cc_report 16:34:09 INFO - PROCESS | 1985 | _x_x_mozilla_cycle_collect,881 16:34:09 INFO - PROCESS | 1985 | __end_cc_report 16:34:09 INFO - PROCESS | 1985 | __startTimestamp1455842049670__endTimestamp 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | ------- Summary: start ------- 16:34:09 INFO - PROCESS | 1985 | Number of tests: 14 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#0] ai-astar Cycles:10 Average:130.80 Median:127.50 stddev:23.79 (18.7%) stddev-sans-first:24.35 16:34:09 INFO - PROCESS | 1985 | Values: 113.0 105.0 132.0 165.0 160.0 123.0 117.0 166.0 113.0 114.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:159.00 stddev:22.11 (13.9%) stddev-sans-first:19.45 16:34:09 INFO - PROCESS | 1985 | Values: 189.0 146.0 145.0 170.0 156.0 174.0 161.0 119.0 157.0 121.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#2] audio-dft Cycles:10 Average:211.90 Median:200.50 stddev:27.51 (13.7%) stddev-sans-first:28.22 16:34:09 INFO - PROCESS | 1985 | Values: 192.0 202.0 197.0 215.0 272.0 252.0 197.0 198.0 199.0 195.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#3] audio-fft Cycles:10 Average:76.50 Median:70.50 stddev:23.38 (33.2%) stddev-sans-first:24.78 16:34:09 INFO - PROCESS | 1985 | Values: 79.0 61.0 71.0 132.0 49.0 61.0 91.0 88.0 63.0 70.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:80.50 stddev:16.57 (20.6%) stddev-sans-first:17.47 16:34:09 INFO - PROCESS | 1985 | Values: 87.0 85.0 119.0 80.0 82.0 81.0 116.0 80.0 80.0 113.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:87.00 stddev:12.69 (14.6%) stddev-sans-first:13.31 16:34:09 INFO - PROCESS | 1985 | Values: 88.0 84.0 126.0 92.0 86.0 90.0 86.0 93.0 86.0 103.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:1.16 (1.2%) stddev-sans-first:1.20 16:34:09 INFO - PROCESS | 1985 | Values: 94.0 95.0 93.0 95.0 97.0 94.0 95.0 96.0 94.0 94.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#7] imaging-desaturate Cycles:10 Average:109.50 Median:91.00 stddev:22.60 (24.8%) stddev-sans-first:23.17 16:34:09 INFO - PROCESS | 1985 | Values: 93.0 94.0 92.0 93.0 114.0 126.0 100.0 90.0 145.0 148.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:1.99 (3.6%) stddev-sans-first:2.00 16:34:09 INFO - PROCESS | 1985 | Values: 54.0 57.0 55.0 55.0 56.0 55.0 55.0 61.0 55.0 55.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:6.26 (9.1%) stddev-sans-first:6.16 16:34:09 INFO - PROCESS | 1985 | Values: 62.0 66.0 64.0 70.0 81.0 75.0 68.0 66.0 73.0 61.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:1.90 (2.2%) stddev-sans-first:1.94 16:34:09 INFO - PROCESS | 1985 | Values: 87.0 85.0 87.0 84.0 85.0 84.0 85.0 90.0 85.0 84.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:128.50 stddev:8.48 (6.6%) stddev-sans-first:8.97 16:34:09 INFO - PROCESS | 1985 | Values: 130.0 126.0 127.0 126.0 123.0 130.0 126.0 143.0 139.0 112.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:147.00 stddev:24.81 (16.9%) stddev-sans-first:26.22 16:34:09 INFO - PROCESS | 1985 | Values: 146.0 188.0 183.0 143.0 148.0 137.0 135.0 127.0 187.0 124.0 16:34:09 INFO - PROCESS | 1985 | 16:34:09 INFO - PROCESS | 1985 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.51 (2.2%) stddev-sans-first:1.51 16:34:09 INFO - PROCESS | 1985 | Values: 70.0 67.0 69.0 68.0 71.0 70.0 66.0 68.0 69.0 68.0 16:34:09 INFO - PROCESS | 1985 | -------- Summary: end -------- 16:34:09 INFO - PROCESS | 1985 | 16:34:10 INFO - TEST-INFO | 1985: exit 0 16:34:10 INFO - TEST-OK | kraken | took 57810ms 16:34:10 INFO - SUITE-END | took 1168s 16:34:10 INFO - Completed test suite (00:19:29) 16:34:10 INFO - Working with test: dromaeo_css 16:34:10 INFO - Generating results file: dromaeo_css 16:34:10 INFO - Working with test: kraken 16:34:10 INFO - Generating results file: kraken 16:34:10 INFO - javascript benchmark 16:34:10 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:34:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 16:34:11 INFO - process_Request line: dromaeo_css 7425.34 graph.html#tests=[[72,1,61]] 16:34:11 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:34:11 INFO - process_Request line: kraken 1521.50 graph.html#tests=[[232,1,61]] 16:34:11 INFO - RETURN: dromaeo_css: 7425.34 16:34:11 INFO - RETURN: kraken: 1521.50 16:34:11 INFO - javascript benchmark 16:34:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2932.882684692612, 3545.3441113394024, 3571.2678900825335, 3586.121400256937, 3588.4437912123612, 5792.304923409197, 5869.7652093916195, 5889.322727886294, 5889.646621202725, 5924.43717846805, 5842.415758424156, 5844.912326315109, 5854.151148083536, 5890.793822216223, 6072.635641861491, 5203.635745497817, 5262.657927234727, 5396.055690254209, 5503.871706300219, 5523.25436066132, 5191.766370513317, 5355.651882627636, 5402.243685883979, 5437.510624043835, 5451.0, 5226.3989641191365, 5310.99091172676, 5327.520523152915, 5360.303160589098, 5383.192521121824, 4790.616750659939, 4999.9500004999845, 5319.441458646825, 5372.435894231088, 5378.596605254583, 5232.398274198478, 5237.580993520509, 5302.337207849019, 5355.303810504648, 5370.892582148335, 4588.839390621312, 5440.857419941817, 5667.3482549506925, 5722.62802917809, 5740.741666625012, 5258.842234732964, 5729.567608097976, 6221.191245138103, 6237.34507876671, 6243.094751261042, 6118.20463339763, 6203.2556093269095, 6274.56078074535, 6314.305426403092, 6332.145160403333, 5934.554908381889, 6016.819495415145, 6020.187274717945, 6023.0, 6073.210482637229, 6199.938000620026, 6297.874042519124, 6313.779972214112, 6376.1392212051705, 6410.230772307353, 6177.382261773877, 6191.25704915413, 6196.8760624787255, 6212.689365531795, 6220.782272620437, 6261.499080073583, 6267.749290028439, 6270.372962703785, 6273.372662733781, 6283.874322513524, 6082.0, 6133.610107582658, 6192.411720886508, 6220.7511699532415, 6259.655718935503, 6181.598196117238, 6214.8135555933395, 6224.782132625427, 6231.470325022424, 6354.3645635437015, 4872.80508779652, 4959.479254678206, 4974.228994505785, 4988.975055124701, 4994.700317980933, 4422.71252368595, 4436.977815110904, 4450.643948484114, 4479.283314669638, 4526.275795872711, 5392.595555333366, 5788.0, 5816.243888294494, 5834.824955251349, 5892.145638882338, 6133.854967164949, 6170.629762214281, 6237.968810156011, 6261.5616906816995, 6268.435840774352, 5792.4497172768515, 5840.036393995028, 5844.620099693507, 5870.0, 5874.324452687995, 5482.671039737628, 5491.862703432446, 5503.587230957614, 5506.834794956158, 5522.30971128609, 6263.3736626337, 6336.651484168415, 6403.0, 6423.614583125028, 6445.871082578416, 4980.950190498049, 6262.624242545462, 6266.216722909637, 6292.4966002720585, 6293.402126797947, 6271.655058971618, 6384.233891932812, 6447.323031081856, 6464.933286007756, 6503.934960650333, 6185.536084793568, 6199.597026193283, 6201.379862013762, 6214.875702485834, 6230.252369715663, 6190.2571691397325, 6234.314225435108, 6253.1245625613365, 6287.371262873676, 6356.0, 5231.738413079407, 6088.086786981811, 6142.897836592492, 6210.7515699371515, 6228.875422491434, 6139.324674285915, 6195.1636529068, 6201.751929922752, 6210.5652604317265, 6216.409441103088, 5913.586048976703, 6078.513718902565, 6114.144019837316, 6114.174586430775, 6252.0, 6119.929102025492, 6220.066989951543, 6221.222347206599, 6224.439800417984, 6243.656598887105, 6058.939410605837, 6090.482309003784, 6132.540059495466, 6133.662648554372, 6143.078538219303], "unit": "score", "name": "dojo.html", "value": 5754.23695557544}, {"lowerIsBetter": false, "replicates": [456.936028955946, 466.36108531312107, 474.9026449577837, 498.87777494513836, 560.6383882395854, 32023.039308820713, 32996.84511042114, 34236.486452703226, 37640.247195056116, 37752.43371349428, 39208.60791392085, 39785.40321895174, 39791.60208397915, 39795.40306895399, 39865.40201896974, 9303.162715355616, 9441.150296473315, 9462.479563623998, 9486.66796662117, 9502.429854208734, 8500.74497765065, 9651.80696386072, 9654.5172741363, 9655.13103820656, 9663.130318271355, 8824.911750882473, 9617.615295388176, 9634.75913102171, 9638.903610963871, 9701.0, 9530.952345238264, 9621.615135394575, 9651.0, 9664.130228279488, 9666.468344241064, 9461.148496635336, 9560.521973901346, 9565.617375304979, 9586.76033099171, 9627.951860240653, 37719.811400943094, 37845.6754013611, 38059.429108563396, 38132.42801357982, 38219.04452388685, 2775.7501824835863, 3177.507486339621, 3231.4344989626957, 3256.0231930420778, 3399.1162297802503, 28257.0, 28529.714702852914, 28551.286217844514, 28620.713792862014, 28623.71376286252, 2795.454886297173, 2838.801283910127, 2870.6555213374318, 2883.3944871576996, 2988.3126880817317, 419823.0, 421308.0, 421532.0, 500882.0, 543433.0, 58334.958276460966, 59141.0, 59430.40569594335, 60156.699216504516, 60245.0, 62644.686776565824, 62915.0, 62997.370026300065, 63156.68421657862, 63494.68252658707, 15894.284757185955, 16439.506814795575, 16460.4238851642, 16595.17024148788, 16668.08325542107, 12763.744725105445, 12856.164349317265, 12935.676608084685, 12957.416916238602, 12979.41592628315, 19667.016649167483, 19707.901460492893, 19742.11160497781, 19842.900785495982, 19890.403287901387, 8378.120297368689, 8506.31949444043, 8520.69589672246, 8548.74353769388, 8551.871721924175, 926.536731634183, 957.7366224288377, 971.8785151856018, 1022.831232846572, 1040.2354269611828, 29330.85334573356, 29762.40475190484, 29889.402211956072, 29924.102276931728, 30379.684125002197, 1032.7831155457288, 1036.7719101797743, 1038.48075962019, 1054.8839627640953, 1081.4430568257353, 13305.334733263298, 14668.339924703414, 14698.0, 14821.258937053104, 15006.549803505912, 558904.0, 563290.0, 568193.0, 572010.0, 578284.0, 55441.0, 55765.0, 56051.43948560462, 56742.43257567454, 56751.864962701344, 1409.0840953380384, 1409.605310513058, 1412.0892024644047, 1425.415579612354, 1425.9429622815178, 28883.0, 28905.4897675049, 28971.710282897744, 29533.26166845846, 29537.26156846096, 45351.546484536055, 45661.54338456573, 45828.541714582425, 51484.0, 51713.44859654216, 514112.0, 518093.0, 520761.0, 523077.0, 524598.0, 25877.482450351265, 30674.386512270077, 31947.36105277835, 33214.0, 33469.0, 35678.10804729799, 38398.80800595979, 40442.79778601088, 41435.96410089772, 41598.58401416068, 34035.638574456745, 34386.656133438344, 35091.298174036885, 35267.82366088153, 36603.63396366109, 33598.83200583982, 33924.15189620279, 34749.305013900084, 34753.957381278604, 35444.759433419706, 35451.468227977115, 35723.46414803728, 35887.64112358948, 36665.45001825028, 37055.62944370522, 29368.412631747673, 30849.845750771103, 30956.0713178605, 30978.69021309758, 31124.844375777975, 18565.35021274249, 22997.770022299563, 23879.52240955206, 23944.40138996539, 23953.281401557982], "unit": "score", "name": "ext.html", "value": 19260.37888176167}, {"lowerIsBetter": false, "replicates": [310.6536212123483, 360.33697995687936, 360.59433137720066, 366.68465119996796, 372.3669761405611, 15394.923025384858, 15866.524004279876, 19200.90399548002, 19630.705539416886, 20461.590768184647, 11788.351640659761, 12078.214916030453, 12237.632871013884, 12259.0, 19866.801331986677, 5120.540645915906, 5200.869978250536, 5371.838844834661, 5380.381256155533, 5397.568194544447, 5170.848506010882, 5171.198464238049, 5208.791648334062, 5281.36623605166, 5325.094733895247, 3903.1998440319667, 5351.57187425005, 5352.2506849041165, 5358.490943360394, 5580.888382232353, 4896.290037944514, 5774.855628609276, 5778.451047150556, 5809.419058094199, 5812.6512409255365, 5344.759485823147, 5566.2207290979295, 5620.971895140498, 5650.180723795027, 5656.745446454919, 11009.669709908716, 18247.270109195615, 19265.036748162536, 23169.76830231693, 23848.64227036596, 1941.4078705994666, 1997.8201961823506, 2021.6462119129094, 2049.6515592349338, 2061.8762874227596, 13338.466461341535, 14163.079399838978, 14183.716325673531, 14370.640733981734, 14681.632959175999, 1735.0197138616768, 1752.7984281807628, 1761.9911900440416, 1804.4225847728733, 1834.2937968882077, 95912.52043739807, 101423.0, 103094.45358319631, 104380.0, 105930.47034764854, 10906.890931090746, 11471.655850324503, 11487.54049837997, 11608.678264346996, 11620.012298954514, 10890.891091088988, 11519.769604607862, 11908.583199587973, 13640.795388069188, 13709.383077761326, 7941.444098913021, 8281.337493000545, 8575.228229459379, 8640.870386944202, 8655.091215422415, 8642.308615310885, 8725.52009639476, 8770.561471926378, 8778.166074222938, 8809.075047120088, 3702.426123950792, 4422.137683151755, 4485.820567177341, 4503.54964503547, 4535.954640453553, 1668.2076013893304, 1872.4850666066668, 1890.4423195157462, 1897.127321432129, 1912.5792325688606, 434.10790824855223, 439.6087482140897, 802.530519646002, 878.8462019146624, 892.4377642085444, 11618.302901825917, 11773.52905883755, 11890.346030968207, 11934.940325298317, 12048.638540843789, 440.65408654206936, 448.52904450327026, 455.5876931377109, 464.6538328944958, 471.82542459290283, 6014.51883849291, 6074.149619053336, 6172.444479996821, 6173.938260617426, 6184.103305020747, 524904.0, 536829.0, 536888.0, 624161.0, 627984.0, 74656.62671686607, 77298.20263480261, 84115.0, 119722.4013879925, 128697.0, 999.8400255959157, 1031.046282188972, 1048.5438834107188, 1049.1292227451197, 1057.6615483045505, 17747.733783992993, 17998.0, 18270.543236418664, 18642.34751783681, 18694.719579206052, 35714.749983750444, 49563.75218124031, 50104.74947625384, 51002.74498627483, 51678.48321516737, 67248.0, 71191.0, 71538.0, 72107.63946180236, 73735.52528949498, 7790.88313675284, 7866.0, 7866.292033716764, 7980.960095199719, 8010.759677209693, 10006.69979900604, 11447.626284845872, 12303.753924921273, 12457.314847683101, 12719.618411447671, 9467.479288639192, 10002.799944001225, 10093.646722364681, 10761.73095672583, 10994.560217591526, 4959.760059985004, 9672.516374181403, 10701.090407315465, 10913.508892100033, 11054.723631909266, 11205.215634905479, 11262.436878155895, 11380.94309528447, 11521.481533330852, 11644.475998579916, 7117.8932316016335, 7507.249275072449, 7844.372450204084, 7903.486273392211, 7926.603669816602, 9933.712168374208, 10474.214433917334, 11026.669199924016, 11080.778384432106, 11096.778064438828], "unit": "score", "name": "jquery.html", "value": 8436.472861763164}, {"lowerIsBetter": false, "replicates": [1496.4463148635004, 1510.9951881998472, 1728.6024214430681, 1870.1677753399742, 1875.8030406807277, 7727.150013498511, 8273.75178744638, 8319.792005199874, 8481.618327175276, 8496.022957359914, 7149.85700285994, 7421.962890185555, 8186.8538404623405, 8440.535770532619, 8590.95704521478, 2461.4215659320043, 2476.5913624252066, 2490.9003639854386, 2492.4516606346574, 2494.713107992577, 2434.926952191437, 2463.051725085846, 2463.408781892351, 2483.8758062096913, 2498.387894965727, 2161.9351419457444, 2349.2717257650097, 2351.47091904321, 2370.360002799252, 2447.877606119687, 2454.7667971542764, 2472.666190064336, 2491.9750802491926, 2493.376655836041, 2498.650188973545, 2458.864762438065, 2473.8639374834556, 2478.8388754731063, 2483.52812965536, 2491.0907518755703, 7508.9487471754, 8085.919140808575, 8483.915160848373, 8505.787355316166, 8510.659573617047, 5233.110371236899, 5331.733413329318, 5402.486763757437, 5416.268803711528, 5438.102713052342, 3521.559805024372, 3573.4997100405963, 3649.033006253345, 3666.2300916807503, 3666.944995825065, 1059.9470026498643, 1073.2111897755144, 1076.8169411200115, 1103.365564800235, 1103.9116870650328, 11643.952044316053, 11678.124140689482, 11696.415179241088, 11707.76584468306, 11724.472398741991, 4779.0, 4797.832075877328, 4825.782839772149, 4833.32333473314, 4865.489123642037, 9925.255605829592, 9967.950160249153, 9970.700878973643, 9973.401595904268, 10004.049615286536, 5390.51485366319, 5391.191321301836, 5409.080456322435, 5428.647137936022, 5429.972850135724, 4903.387076615423, 4913.410390753133, 4946.703197808143, 4966.106100901872, 4966.528179822911, 3941.625545573166, 3973.7482692951626, 3981.900452488711, 3986.60133986599, 3995.081131339808, 1309.6594885329691, 1313.2711345203313, 1317.9934100329629, 1319.0502837956847, 1328.4154971812372, 944.6410364061612, 1101.3942331717524, 1141.395060617874, 1235.4131787401093, 1365.378752667534, 7761.146273909865, 7767.766966990999, 7776.183500732342, 7787.493812902257, 7900.841983160304, 1172.0916289875415, 1177.4407156600716, 1181.173178774861, 1181.6750393641646, 1189.2210602055495, 4766.189747742892, 6080.422359875804, 6108.572399932051, 6169.167162433014, 6207.317195108534, 9197.264218862474, 10447.955204479491, 10538.789224215472, 10578.153747700166, 10587.629432969808, 10279.383237005653, 10402.739931501774, 10421.583136674448, 10451.895481045245, 10551.15590752738, 8018.238267364591, 8202.917970820336, 8207.548584827891, 8219.917800822035, 8277.04813946392, 7697.422693298137, 7703.845923081619, 7725.343345815669, 7742.070951485858, 7758.883616745867, 9164.541772911194, 9368.765780855532, 9435.292353073684, 9484.099010593982, 9489.620415183315, 9339.112784285482, 9755.073268039525, 9755.951220243853, 9844.606215751577, 9903.257255705706, 7360.96319518399, 7401.888971665537, 7426.851462970602, 7440.107187137578, 7442.255774422514, 7988.520688758693, 8080.949476568244, 8081.313088387553, 8098.271155595789, 8156.592170391338, 6401.967990160019, 7321.267873212636, 7343.632818359168, 7454.142773580891, 7505.737299194502, 6368.395002474757, 7105.680244388912, 7106.4314854810455, 7127.861641507423, 7206.2793720627515, 6389.840253993687, 7497.587632680255, 7571.545707257582, 7573.545587264562, 7576.2423757626, 6932.826679333057, 6975.686094125675, 6979.9181126925405, 6981.197162326397, 6984.860302794017, 6939.548929319578, 7091.539049961736, 7095.432365410858, 7097.751578694721, 7098.787036388917], "unit": "score", "name": "mootools.html", "value": 4869.346802526751}, {"lowerIsBetter": false, "replicates": [281.56779343707404, 331.8805230117156, 333.4681183512297, 338.9186595217148, 344.24438357804627, 6695.129633147684, 6821.079154314172, 6827.453803695705, 6834.282400347966, 6849.486288528368, 6891.345322194396, 6925.619090950008, 6929.549579277344, 6942.965285173567, 6945.270746571613, 5099.337086178792, 5123.975204959004, 5144.022635699224, 5150.0, 5181.1969144782615, 3896.7530390275124, 5125.641205115643, 5134.64057515974, 5140.511651393112, 5151.124308867502, 4939.753012349386, 4950.529699678525, 4955.306257124005, 4964.826231081913, 4979.751012449363, 4931.926021109686, 4946.134426475388, 4961.206207006861, 4977.427595826472, 4981.27771473138, 4219.409282700424, 4226.1336426032585, 4226.323788193905, 4230.894227644303, 4236.788160591958, 6293.716782744787, 6504.536479292122, 6528.151340325775, 6556.114924485181, 6592.241892182413, 5791.88416231673, 5794.797182098607, 5802.448767367094, 5808.4191580842, 5823.272090988627, 7329.497453022171, 7333.303336183054, 7341.192468828424, 7348.816279592999, 7362.300581444754, 4445.444319460067, 4523.525029871849, 4609.0, 4647.302904564309, 4659.347691323217, 6063.333033366326, 6822.976553517012, 7170.39051680613, 7458.142313633947, 7725.922740772577, 3802.16352402471, 3949.940750888739, 4030.7581545107387, 4321.157374311979, 4690.319903613957, 4401.1417773534495, 4588.770561471913, 4767.332573439721, 4821.7589120543835, 4828.66199366048, 5687.345955215121, 5692.430756924357, 5713.314402271671, 5732.455416735404, 5753.280839895013, 6064.727087281083, 7239.131304243525, 7305.634718264172, 7305.707771689073, 7310.0, 1674.0541593999594, 1699.2947926610318, 1700.1924086059023, 1703.3612395351743, 1707.675541647083, 1034.846146546595, 1049.2393015064017, 1058.915286777056, 1072.7371793910543, 1093.0818112785298, 6787.490938179656, 6815.795526134224, 6833.863322733518, 6836.658167091626, 6843.3840954314355, 7590.1650818409935, 7607.695692172251, 7612.1246056703085, 7612.885806712793, 7627.351675107567, 6630.701618427182, 6765.9661701691175, 6800.08198893153, 6871.278515755874, 6897.1033765611155, 4014.197160567898, 4042.292598795199, 4058.4723985882238, 4074.8777536673947, 4077.0, 8059.919400806034, 8061.717839875576, 8086.7169649062, 8100.392470564731, 8124.7562573122905, 7646.4265180111715, 7967.521948683097, 7969.880451793228, 7974.4417890748255, 7991.800204994922, 8030.799230019296, 8040.8793868092025, 8043.7586872395095, 8070.2333278338465, 8070.273675369245, 7029.578225306498, 7657.655405506877, 7690.2694244046725, 7691.807704807425, 7696.307332340116, 7506.24937506245, 7522.962385188039, 7545.811354716176, 7546.735864244725, 7558.014584239085, 6297.779577714758, 7653.617319134132, 8041.798955025937, 8059.904424849464, 8074.192580741878, 4596.264597664358, 4760.119377915097, 4781.402324709411, 4783.402074740658, 4801.471838097877, 6269.467095296768, 7573.507721998052, 7653.464257501922, 7662.463627546018, 7663.655135518804, 7343.118825740945, 7351.264873512606, 7352.0, 7354.595497247703, 7376.004239427823, 7152.284771523015, 7393.667284972082, 7457.664405101892, 7464.216257292906, 7472.589007604634, 7242.746503872339, 7243.7464688735645, 7252.5648461092505, 7272.0, 7298.0, 7218.927810722035, 7423.183449820407, 7427.480076394817, 7435.367993720594, 7435.851282974419, 6232.875342493034, 7058.6470676467, 7251.746188883364, 7263.818404539928, 7268.382187513909], "unit": "score", "name": "prototype.html", "value": 5296.865306552657}, {"lowerIsBetter": false, "replicates": [647.1683886206223, 673.7069374821956, 678.4707927816304, 692.5360008794107, 706.9045678833356, 13142.817146456817, 14768.784682297648, 14927.477538286163, 14946.02850814699, 14955.925220373896, 12063.51745930164, 13611.319434028308, 13621.727565448686, 14576.0, 15201.087934723924, 864.0107077396377, 878.0078511282258, 891.4918496457022, 893.5041052216018, 893.9910600894005, 674.7739507265072, 783.3772151139829, 871.7428358634187, 891.4606662968907, 892.6340200517789, 920.4523308631353, 937.4750139921666, 941.6092321686492, 943.528235882059, 944.5796620503878, 904.3759805734055, 910.4582773249906, 923.2890674180843, 928.8885333759993, 931.3061768982118, 658.5982550644103, 666.4601672645173, 694.3056943056943, 700.7757517594372, 703.1737708192904, 14231.146131232159, 14249.145051296955, 14276.0, 14328.64178395538, 14345.569632910925, 12424.937875310565, 12498.437570309357, 12554.999999999909, 12683.556075537312, 12877.742445151045, 9988.650397236062, 9995.75010624733, 10239.436830974293, 10393.0, 10766.730831729192, 3460.3944309745693, 3593.0, 3593.586737525192, 3649.6350364963555, 3659.634036596319, 65450.67274663596, 75280.62359688221, 83303.5834820822, 84376.0, 85667.0, 8702.216800487986, 9397.57710903011, 9475.241980641533, 9603.231741460666, 9658.179054780281, 20383.8980805095, 20384.184632614826, 20395.8980205098, 20423.285185018452, 20437.795622043886, 7354.0, 7495.700171993169, 7550.35821955129, 7623.275788800166, 7632.732854350071, 4116.320807066861, 4134.441850350164, 4143.19207754485, 4180.101278225196, 4185.183889141649, 3458.152752575635, 3479.251960828434, 3485.233248685285, 3492.406290930548, 3502.9299414012085, 627.0500192208807, 634.1344065350763, 637.2448648351718, 656.6847913001786, 657.7697805767943, 458.9701669391546, 534.8447353715954, 544.7848100000477, 582.7814569536424, 597.1103056445864, 8703.43427677199, 8984.101589841095, 9064.274858011475, 9108.362414630912, 9218.170364667212, 591.2343515147894, 602.9517638588902, 618.7679620142446, 622.2253294648192, 635.8505751148476, 4201.609318262423, 4268.573142685706, 4295.312749959991, 4337.7180483268485, 4399.428074350314, 95028.57457138148, 95559.0, 95829.0, 96713.51643241738, 100709.0, 75992.0, 83579.91050223794, 83981.58009210037, 85445.0, 89440.55279723559, 54435.0, 63275.0, 70714.29285707077, 71797.6410117946, 77202.84195737068, 7726.729564465217, 8743.169398907094, 8796.856408666832, 8954.955225223832, 9060.946482974448, 51126.97746045133, 53100.406987790426, 53190.73404632952, 53241.93516129733, 53942.0, 64573.0, 65225.0, 68508.62982740418, 73404.0, 74821.0, 11409.771804564029, 11550.537978480766, 12000.63998080059, 12259.938700306442, 12449.813252801034, 12263.448144833326, 12288.569900053455, 12337.691557711129, 12453.377331133588, 12526.0, 11826.053915686896, 11847.881521185023, 11999.460024298753, 12097.334646594521, 12104.636860894187, 10323.741906452398, 11812.409379530816, 11856.822147667619, 12022.33877136731, 12087.818682719942, 8873.467591944504, 10875.129989600971, 11386.772264554496, 11506.30962142274, 11696.824547631622, 8760.299176066026, 9828.16460600857, 9959.850602241117, 10006.749831253986, 10237.181025517792, 9846.950765246127, 10013.24900632441, 10103.191744660557, 10151.441670708182, 10160.847587286344], "unit": "score", "name": "yui.html", "value": 6949.651351552549}], "name": "dromaeo_css", "value": 7425.340868390552}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 132.0, 165.0, 160.0, 123.0, 117.0, 166.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 130.8}, {"lowerIsBetter": true, "replicates": [189.0, 146.0, 145.0, 170.0, 156.0, 174.0, 161.0, 119.0, 157.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 153.8}, {"lowerIsBetter": true, "replicates": [192.0, 202.0, 197.0, 215.0, 272.0, 252.0, 197.0, 198.0, 199.0, 195.0], "unit": "score", "name": "audio-dft", "value": 211.9}, {"lowerIsBetter": true, "replicates": [79.0, 61.0, 71.0, 132.0, 49.0, 61.0, 91.0, 88.0, 63.0, 70.0], "unit": "score", "name": "audio-fft", "value": 76.5}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 119.0, 80.0, 82.0, 81.0, 116.0, 80.0, 80.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 92.3}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 126.0, 92.0, 86.0, 90.0, 86.0, 93.0, 86.0, 103.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.4}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 93.0, 95.0, 97.0, 94.0, 95.0, 96.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 92.0, 93.0, 114.0, 126.0, 100.0, 90.0, 145.0, 148.0], "unit": "score", "name": "imaging-desaturate", "value": 109.5}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 55.0, 55.0, 56.0, 55.0, 55.0, 61.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [62.0, 66.0, 64.0, 70.0, 81.0, 75.0, 68.0, 66.0, 73.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 87.0, 84.0, 85.0, 84.0, 85.0, 90.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [130.0, 126.0, 127.0, 126.0, 123.0, 130.0, 126.0, 143.0, 139.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.2}, {"lowerIsBetter": true, "replicates": [146.0, 188.0, 183.0, 143.0, 148.0, 137.0, 135.0, 127.0, 187.0, 124.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.8}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 69.0, 68.0, 71.0, 70.0, 66.0, 68.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1521.4999999999998}]} 16:34:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1521.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7425.34"}}} 16:34:11 INFO - Return code: 0 16:34:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:34:11 ERROR - # TBPL SUCCESS # 16:34:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:34:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:34:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:34:11 INFO - 2016-02-18 16:34:11.560 screenresolution[1990:14295] starting screenresolution argv=screenresolution get 16:34:11 INFO - 2016-02-18 16:34:11.563 screenresolution[1990:14295] Display 0: 1600x1200x32@60 16:34:11 INFO - 2016-02-18 16:34:11.569 screenresolution[1991:14298] starting screenresolution argv=screenresolution list 16:34:11 INFO - Available Modes on Display 0 16:34:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:34:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:34:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:34:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:34:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:34:11 INFO - Intel Iris: 16:34:11 INFO - Chipset Model: Intel Iris 16:34:11 INFO - Type: GPU 16:34:11 INFO - Bus: Built-In 16:34:11 INFO - VRAM (Dynamic, Max): 1536 MB 16:34:11 INFO - Vendor: Intel (0x8086) 16:34:11 INFO - Device ID: 0x0a2e 16:34:11 INFO - Revision ID: 0x0009 16:34:11 INFO - Displays: 16:34:11 INFO - Display: 16:34:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:34:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:34:11 INFO - Display Serial Number: 1600x1200 60 16:34:11 INFO - Main Display: Yes 16:34:11 INFO - Mirror: Off 16:34:11 INFO - Online: Yes 16:34:11 INFO - Rotation: Supported 16:34:11 INFO - Return code: 0 16:34:11 INFO - Running post-action listener: _resource_record_post_action 16:34:11 INFO - Running post-run listener: _resource_record_post_run 16:34:12 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 2396160; Write bytes: 711352320; Read time: 35; Write time: 2049 16:34:12 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 389188096; Write bytes: 383706624; Read time: 28957; Write time: 664 16:34:12 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 2396160; Write bytes: 304335360; Read time: 35; Write time: 1333 16:34:12 INFO - Running post-run listener: _upload_blobber_files 16:34:12 INFO - Blob upload gear active. 16:34:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:34:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:34:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:34:13 INFO - (blobuploader) - INFO - Open directory for files ... 16:34:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:34:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:34:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:14 INFO - (blobuploader) - INFO - Done attempting. 16:34:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:34:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:34:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:15 INFO - (blobuploader) - INFO - Done attempting. 16:34:15 INFO - (blobuploader) - INFO - Iteration through files over. 16:34:15 INFO - Return code: 0 16:34:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:34:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:34:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0b5d7351b69062d5d4b9ab0755ae409ddac2351bc4ed3cac947cb7800729fae0ad6cc9cd7b0cbf5445f6188a5f8999ac5cd94139d6aab5865b9fb9fb04313f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f209474958ff1944b66f549175227158f5b064c7605c5f0f0b309b5f895f854be060e970cc1f4c8344e8190bb1bf3a554685b809df7526bb3022779fa54f87b9"} 16:34:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:34:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:34:15 INFO - Contents: 16:34:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0b5d7351b69062d5d4b9ab0755ae409ddac2351bc4ed3cac947cb7800729fae0ad6cc9cd7b0cbf5445f6188a5f8999ac5cd94139d6aab5865b9fb9fb04313f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f209474958ff1944b66f549175227158f5b064c7605c5f0f0b309b5f895f854be060e970cc1f4c8344e8190bb1bf3a554685b809df7526bb3022779fa54f87b9"} 16:34:15 INFO - Running post-run listener: copy_logs_to_upload_dir 16:34:15 INFO - Copying logs to upload dir... 16:34:15 INFO - mkdir: /builds/slave/test/build/upload/logs 16:34:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.301893 ========= master_lag: 3.60 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-18 16:34:18.508166) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-02-18 16:34:18.517024) ========= 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.fcMJ8FWzjR/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.g2hI1nn215/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0b5d7351b69062d5d4b9ab0755ae409ddac2351bc4ed3cac947cb7800729fae0ad6cc9cd7b0cbf5445f6188a5f8999ac5cd94139d6aab5865b9fb9fb04313f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f209474958ff1944b66f549175227158f5b064c7605c5f0f0b309b5f895f854be060e970cc1f4c8344e8190bb1bf3a554685b809df7526bb3022779fa54f87b9"} build_url:https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011158 build_url: 'https://queue.taskcluster.net/v1/task/TFeh3pnGSpGIjWIBjKR2hA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0b5d7351b69062d5d4b9ab0755ae409ddac2351bc4ed3cac947cb7800729fae0ad6cc9cd7b0cbf5445f6188a5f8999ac5cd94139d6aab5865b9fb9fb04313f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f209474958ff1944b66f549175227158f5b064c7605c5f0f0b309b5f895f854be060e970cc1f4c8344e8190bb1bf3a554685b809df7526bb3022779fa54f87b9"}' ========= master_lag: 3.69 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-02-18 16:34:22.213721) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 16:34:22.214125) ========= 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.fcMJ8FWzjR/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.g2hI1nn215/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005230 ========= master_lag: 1.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 16:34:23.366062) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-02-18 16:34:23.366332) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-02-18 16:34:28.084065) ========= ========= Total master_lag: 37.76 =========