builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0116 starttime: 1460608013.88 results: success (0) buildid: 20160413184655 builduid: e019b49d120e47129b86f5c94743fb29 revision: f6fe48816b24556b76f34e7e3ec9713a439bb191 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:53.875612) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:53.876089) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:53.876376) ========= 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.xi0FpsdfDB/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.h4x35AdMTC/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005775 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:53.906899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:53.907216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:53.925544) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:53.925886) ========= 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.xi0FpsdfDB/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.h4x35AdMTC/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005580 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:53.973609) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:53.976947) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:53.977313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:53.977580) ========= 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.xi0FpsdfDB/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.h4x35AdMTC/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-04-13 21:26:53-- 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% 14.2M=0.001s 2016-04-13 21:26:54 (14.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173253 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:54.166446) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:54.169777) ========= 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.xi0FpsdfDB/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.h4x35AdMTC/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.026346 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:54.218681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 21:26:54.219050) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f6fe48816b24556b76f34e7e3ec9713a439bb191 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f6fe48816b24556b76f34e7e3ec9713a439bb191 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xi0FpsdfDB/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.h4x35AdMTC/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-04-13 21:26:54,297 truncating revision to first 12 chars 2016-04-13 21:26:54,297 Setting DEBUG logging. 2016-04-13 21:26:54,298 attempt 1/10 2016-04-13 21:26:54,298 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f6fe48816b24?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 21:26:55,573 unpacking tar archive at: fx-team-f6fe48816b24/testing/mozharness/ program finished with exit code 0 elapsedTime=1.522578 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 21:26:55.761513) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:55.761946) ========= echo f6fe48816b24556b76f34e7e3ec9713a439bb191 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f6fe48816b24556b76f34e7e3ec9713a439bb191'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xi0FpsdfDB/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.h4x35AdMTC/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 f6fe48816b24556b76f34e7e3ec9713a439bb191 program finished with exit code 0 elapsedTime=0.005291 script_repo_revision: 'f6fe48816b24556b76f34e7e3ec9713a439bb191' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:55.814602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:55.814926) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 21:26:55.834905) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-13 21:26:55.835286) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xi0FpsdfDB/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.h4x35AdMTC/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 21:26:56 INFO - MultiFileLogger online at 20160413 21:26:56 in /builds/slave/test 21:26:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:26:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:26:56 INFO - {'append_to_log': False, 21:26:56 INFO - 'base_work_dir': '/builds/slave/test', 21:26:56 INFO - 'blob_upload_branch': 'Fx-Team', 21:26:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:26:56 INFO - 'branch': 'Fx-Team', 21:26:56 INFO - 'buildbot_json_path': 'buildprops.json', 21:26:56 INFO - 'config_files': ('talos/mac_config.py',), 21:26:56 INFO - 'default_actions': ('clobber', 21:26:56 INFO - 'read-buildbot-config', 21:26:56 INFO - 'download-and-extract', 21:26:56 INFO - 'populate-webroot', 21:26:56 INFO - 'create-virtualenv', 21:26:56 INFO - 'install', 21:26:56 INFO - 'run-tests'), 21:26:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:26:56 INFO - 'download_minidump_stackwalk': True, 21:26:56 INFO - 'download_symbols': 'ondemand', 21:26:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:26:56 INFO - 'tooltool.py': '/tools/tooltool.py', 21:26:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:26:56 INFO - '/tools/misc-python/virtualenv.py')}, 21:26:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:26:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:26:56 INFO - 'installer_path': 'installer.exe', 21:26:56 INFO - 'log_level': 'info', 21:26:56 INFO - 'log_name': 'talos', 21:26:56 INFO - 'log_to_console': True, 21:26:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:26:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:26:56 INFO - 'opt_config_files': (), 21:26:56 INFO - 'pip_index': False, 21:26:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:26:56 INFO - 'cmd': ('bash', 21:26:56 INFO - '-c', 21:26:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:26:56 INFO - 'enabled': True, 21:26:56 INFO - 'halt_on_failure': False, 21:26:56 INFO - 'name': 'check_screen_resolution'},), 21:26:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:26:56 INFO - 'cmd': ('bash', 21:26:56 INFO - '-c', 21:26:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:26:56 INFO - 'enabled': True, 21:26:56 INFO - 'halt_on_failure': False, 21:26:56 INFO - 'name': 'check_screen_resolution'},), 21:26:56 INFO - 'run_cmd_checks_enabled': True, 21:26:56 INFO - 'sps_profile': False, 21:26:56 INFO - 'sps_profile_interval': 0, 21:26:56 INFO - 'suite': 'dromaeojs-e10s', 21:26:56 INFO - 'system_bits': '32', 21:26:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:26:56 INFO - 'title': 't-yosemite-r7-0116', 21:26:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:26:56 INFO - 'use_talos_json': True, 21:26:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:26:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:26:56 INFO - 'work_dir': 'build'} 21:26:56 INFO - ##### 21:26:56 INFO - ##### Running clobber step. 21:26:56 INFO - ##### 21:26:56 INFO - Running pre-action listener: _resource_record_pre_action 21:26:56 INFO - Running main action method: clobber 21:26:56 INFO - rmtree: /builds/slave/test/build 21:26:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:26:57 INFO - Running post-action listener: _resource_record_post_action 21:26:57 INFO - ##### 21:26:57 INFO - ##### Running read-buildbot-config step. 21:26:57 INFO - ##### 21:26:57 INFO - Running pre-action listener: _resource_record_pre_action 21:26:57 INFO - Running main action method: read_buildbot_config 21:26:57 INFO - Using buildbot properties: 21:26:57 INFO - { 21:26:57 INFO - "project": "", 21:26:57 INFO - "product": "firefox", 21:26:57 INFO - "script_repo_revision": "production", 21:26:57 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 21:26:57 INFO - "repository": "", 21:26:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 21:26:57 INFO - "buildid": "20160413184655", 21:26:57 INFO - "pgo_build": "False", 21:26:57 INFO - "basedir": "/builds/slave/test", 21:26:57 INFO - "buildnumber": 684, 21:26:57 INFO - "slavename": "t-yosemite-r7-0116", 21:26:57 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:26:57 INFO - "platform": "yosemite_r7", 21:26:57 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 21:26:57 INFO - "branch": "fx-team", 21:26:57 INFO - "repo_path": "integration/fx-team", 21:26:57 INFO - "revision": "f6fe48816b24556b76f34e7e3ec9713a439bb191", 21:26:57 INFO - "stage_platform": "macosx64", 21:26:57 INFO - "builduid": "e019b49d120e47129b86f5c94743fb29", 21:26:57 INFO - "slavebuilddir": "test" 21:26:57 INFO - } 21:26:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 21:26:57 INFO - Running post-action listener: _resource_record_post_action 21:26:57 INFO - ##### 21:26:57 INFO - ##### Running download-and-extract step. 21:26:57 INFO - ##### 21:26:57 INFO - Running pre-action listener: _resource_record_pre_action 21:26:57 INFO - Running main action method: download_and_extract 21:26:57 INFO - mkdir: /builds/slave/test/build/tests 21:26: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')]} 21:26:57 INFO - https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:26:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:26:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:26:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 21:26:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 21:26:59 INFO - Downloaded 1199 bytes. 21:26:59 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 21:26:59 INFO - Using the following test package requirements: 21:26:59 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:26:59 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:26:59 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 21:26:59 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:26:59 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 21:26:59 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:26:59 INFO - u'jsshell-mac.zip'], 21:26:59 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:26:59 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 21:26:59 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:26:59 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:26:59 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 21:26:59 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:26:59 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 21:26:59 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:26:59 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 21:26:59 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:26:59 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 21:26:59 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:26:59 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')]} 21:26:59 INFO - https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:26:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:26:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:26:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:26:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:27:00 INFO - Downloaded 18031130 bytes. 21:27:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:27:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:27:03 INFO - Return code: 0 21:27:03 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:27:03 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')]} 21:27:03 INFO - https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:27:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:27:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:27:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:27:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:27:05 INFO - Downloaded 18031130 bytes. 21:27:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:27:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:27:09 INFO - Return code: 0 21:27:09 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')]} 21:27:09 INFO - https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:27:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:27:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:27:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:27:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:27:10 INFO - Downloaded 10841076 bytes. 21:27:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:27:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 21:27:10 INFO - Return code: 0 21:27:10 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')]} 21:27:10 INFO - https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:27:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:27:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:27:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 21:27:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 21:27:13 INFO - Downloaded 109324105 bytes. 21:27:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:27:13 INFO - mkdir: /builds/slave/test/properties 21:27:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:27:13 INFO - Writing to file /builds/slave/test/properties/build_url 21:27:13 INFO - Contents: 21:27:13 INFO - build_url:https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:27:14 INFO - Running post-action listener: _resource_record_post_action 21:27:14 INFO - Running post-action listener: set_extra_try_arguments 21:27:14 INFO - ##### 21:27:14 INFO - ##### Running populate-webroot step. 21:27:14 INFO - ##### 21:27:14 INFO - Running pre-action listener: _resource_record_pre_action 21:27:14 INFO - Running main action method: populate_webroot 21:27:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:27:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:27:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:27:14 INFO - '--tppagecycles', 21:27:14 INFO - '7'], 21:27:14 INFO - 'tests': ['tsvgm']}}, 21:27:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:27:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:27:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:27:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:27:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:27:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:27:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:27:14 INFO - 'talos_options': ['--disable-e10s'], 21:27:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:27:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:27:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:27:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:27:14 INFO - 'talos_options': ['--disable-e10s'], 21:27:14 INFO - 'tests': ['damp', 'tps']}, 21:27:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:27:14 INFO - 'tests': ['damp', 'tps']}, 21:27:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:27:14 INFO - 'tests': ['dromaeo_dom']}, 21:27:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:27:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:27:14 INFO - 'tests': ['a11yr', 21:27:14 INFO - 'ts_paint', 21:27:14 INFO - 'tpaint', 21:27:14 INFO - 'sessionrestore', 21:27:14 INFO - 'sessionrestore_no_auto_restore', 21:27:14 INFO - 'tabpaint']}, 21:27:14 INFO - 'other-e10s': {'tests': ['a11yr', 21:27:14 INFO - 'ts_paint', 21:27:14 INFO - 'tpaint', 21:27:14 INFO - 'sessionrestore', 21:27:14 INFO - 'sessionrestore_no_auto_restore', 21:27:14 INFO - 'tabpaint']}, 21:27:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:27:14 INFO - 'ts_paint', 21:27:14 INFO - 'tpaint', 21:27:14 INFO - 'sessionrestore', 21:27:14 INFO - 'sessionrestore_no_auto_restore', 21:27:14 INFO - 'tabpaint']}, 21:27:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:27:14 INFO - 'ts_paint', 21:27:14 INFO - 'tpaint', 21:27:14 INFO - 'sessionrestore', 21:27:14 INFO - 'sessionrestore_no_auto_restore', 21:27:14 INFO - 'tabpaint']}, 21:27:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:27:14 INFO - 'tests': ['a11yr', 21:27:14 INFO - 'ts_paint', 21:27:14 INFO - 'tpaint', 21:27:14 INFO - 'sessionrestore', 21:27:14 INFO - 'sessionrestore_no_auto_restore', 21:27:14 INFO - 'tabpaint']}, 21:27:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:27:14 INFO - 'tests': ['a11yr', 21:27:14 INFO - 'ts_paint', 21:27:14 INFO - 'tpaint', 21:27:14 INFO - 'sessionrestore', 21:27:14 INFO - 'sessionrestore_no_auto_restore', 21:27:14 INFO - 'tabpaint']}, 21:27:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:27:14 INFO - 'tests': ['tsvgx', 21:27:14 INFO - 'tsvgr_opacity', 21:27:14 INFO - 'tart', 21:27:14 INFO - 'tscrollx', 21:27:14 INFO - 'cart']}, 21:27:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:27:14 INFO - 'tsvgr_opacity', 21:27:14 INFO - 'tart', 21:27:14 INFO - 'tscrollx', 21:27:14 INFO - 'cart']}, 21:27:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:27:14 INFO - 'talos_options': ['--disable-e10s'], 21:27:14 INFO - 'tests': ['tp5o']}, 21:27:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:27:14 INFO - 'tests': ['tp5o']}, 21:27:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:27:14 INFO - 'talos_options': ['--disable-e10s', 21:27:14 INFO - '--xperf_path', 21:27:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:27:14 INFO - 'tests': ['tp5n']}, 21:27:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:27:14 INFO - 'talos_options': ['--xperf_path', 21:27:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:27:14 INFO - 'tests': ['tp5n']}}, 21:27:14 INFO - 'talos.zip': {'path': '', 21:27:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:27:14 INFO - Running post-action listener: _resource_record_post_action 21:27:14 INFO - ##### 21:27:14 INFO - ##### Running create-virtualenv step. 21:27:14 INFO - ##### 21:27:14 INFO - Running pre-action listener: _resource_record_pre_action 21:27:14 INFO - Running main action method: create_virtualenv 21:27:14 INFO - Creating virtualenv /builds/slave/test/build/venv 21:27:14 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 21:27:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:27:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:27:15 INFO - Using real prefix '/tools/python27' 21:27:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:27:15 INFO - Installing distribute.............................................................................................................................................................................................done. 21:27:18 INFO - Installing pip.................done. 21:27:18 INFO - Return code: 0 21:27:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:27:18 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')]} 21:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:18 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')]} 21:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:18 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 0x1037a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a1ccc2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647e00>, '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 0x1034b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103642b20>, '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.xi0FpsdfDB/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.h4x35AdMTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 21:27:18 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 21:27:18 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 21:27:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xi0FpsdfDB/Render', 21:27:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:27:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:27:18 INFO - 'HOME': '/Users/cltbld', 21:27:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:27:18 INFO - 'LOGNAME': 'cltbld', 21:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:27:18 INFO - 'MOZ_NO_REMOTE': '1', 21:27:18 INFO - 'NO_EM_RESTART': '1', 21:27:18 INFO - 'PAGER': '/bin/cat', 21:27:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:27:18 INFO - 'PWD': '/builds/slave/test', 21:27:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:27:18 INFO - 'SHELL': '/bin/bash', 21:27:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h4x35AdMTC/Listeners', 21:27:18 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 21:27:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:27:18 INFO - 'USER': 'cltbld', 21:27:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:27:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:27:18 INFO - 'XPC_FLAGS': '0x0', 21:27:18 INFO - 'XPC_SERVICE_NAME': '0', 21:27:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:27:18 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 21:27:18 INFO - Cleaning up... 21:27:18 INFO - Return code: 0 21:27:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:27:18 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')]} 21:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:18 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')]} 21:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:18 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 0x1037a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a1ccc2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647e00>, '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 0x1034b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103642b20>, '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.xi0FpsdfDB/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.h4x35AdMTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 21:27:18 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 21:27:18 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 21:27:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xi0FpsdfDB/Render', 21:27:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:27:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:27:18 INFO - 'HOME': '/Users/cltbld', 21:27:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:27:18 INFO - 'LOGNAME': 'cltbld', 21:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:27:18 INFO - 'MOZ_NO_REMOTE': '1', 21:27:18 INFO - 'NO_EM_RESTART': '1', 21:27:18 INFO - 'PAGER': '/bin/cat', 21:27:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:27:18 INFO - 'PWD': '/builds/slave/test', 21:27:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:27:18 INFO - 'SHELL': '/bin/bash', 21:27:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h4x35AdMTC/Listeners', 21:27:18 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 21:27:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:27:18 INFO - 'USER': 'cltbld', 21:27:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:27:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:27:18 INFO - 'XPC_FLAGS': '0x0', 21:27:18 INFO - 'XPC_SERVICE_NAME': '0', 21:27:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:27:19 INFO - Downloading/unpacking psutil>=0.7.1 21:27:19 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 21:27:19 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 21:27:19 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 21:27:19 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 21:27:19 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 21:27:19 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 21:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:27:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:27:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:27:22 INFO - Installing collected packages: psutil 21:27:22 INFO - Running setup.py install for psutil 21:27:22 INFO - building 'psutil._psutil_osx' extension 21:27:22 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 21:27:22 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 21:27:22 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 21:27:22 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 21:27:23 INFO - building 'psutil._psutil_posix' extension 21:27:23 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 21:27:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:27:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:27:23 INFO - ^ 21:27:23 INFO - 1 warning generated. 21:27:23 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 21:27:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:27:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:27:23 INFO - Successfully installed psutil 21:27:23 INFO - Cleaning up... 21:27:23 INFO - Return code: 0 21:27:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:27:23 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')]} 21:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:23 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')]} 21:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:23 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 0x1037a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a1ccc2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647e00>, '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 0x1034b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103642b20>, '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.xi0FpsdfDB/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.h4x35AdMTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 21:27:23 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 21:27:23 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 21:27:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xi0FpsdfDB/Render', 21:27:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:27:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:27:23 INFO - 'HOME': '/Users/cltbld', 21:27:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:27:23 INFO - 'LOGNAME': 'cltbld', 21:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:27:23 INFO - 'MOZ_NO_REMOTE': '1', 21:27:23 INFO - 'NO_EM_RESTART': '1', 21:27:23 INFO - 'PAGER': '/bin/cat', 21:27:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:27:23 INFO - 'PWD': '/builds/slave/test', 21:27:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:27:23 INFO - 'SHELL': '/bin/bash', 21:27:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h4x35AdMTC/Listeners', 21:27:23 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 21:27:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:27:23 INFO - 'USER': 'cltbld', 21:27:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:27:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:27:23 INFO - 'XPC_FLAGS': '0x0', 21:27:23 INFO - 'XPC_SERVICE_NAME': '0', 21:27:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:27:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:27:23 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 21:27:23 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 21:27:23 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 21:27:23 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 21:27:23 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 21:27:23 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 21:27:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:27:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:27:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:27:26 INFO - Installing collected packages: mozsystemmonitor 21:27:26 INFO - Running setup.py install for mozsystemmonitor 21:27:26 INFO - Successfully installed mozsystemmonitor 21:27:26 INFO - Cleaning up... 21:27:26 INFO - Return code: 0 21:27:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:27: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')]} 21:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27: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')]} 21:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:26 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 0x1037a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a1ccc2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647e00>, '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 0x1034b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103642b20>, '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.xi0FpsdfDB/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.h4x35AdMTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 21:27:26 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 21:27:26 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 21:27:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xi0FpsdfDB/Render', 21:27:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:27:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:27:26 INFO - 'HOME': '/Users/cltbld', 21:27:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:27:26 INFO - 'LOGNAME': 'cltbld', 21:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:27:26 INFO - 'MOZ_NO_REMOTE': '1', 21:27:26 INFO - 'NO_EM_RESTART': '1', 21:27:26 INFO - 'PAGER': '/bin/cat', 21:27:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:27:26 INFO - 'PWD': '/builds/slave/test', 21:27:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:27:26 INFO - 'SHELL': '/bin/bash', 21:27:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h4x35AdMTC/Listeners', 21:27:26 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 21:27:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:27:26 INFO - 'USER': 'cltbld', 21:27:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:27:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:27:26 INFO - 'XPC_FLAGS': '0x0', 21:27:26 INFO - 'XPC_SERVICE_NAME': '0', 21:27:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:27:26 INFO - Downloading/unpacking blobuploader==1.2.4 21:27:26 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 21:27:26 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 21:27:26 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 21:27:26 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 21:27:26 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 21:27:26 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 21:27:29 INFO - Downloading blobuploader-1.2.4.tar.gz 21:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:27:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:27:29 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 21:27:29 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 21:27:29 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 21:27:29 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 21:27:29 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 21:27:29 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 21:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:27:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:27:29 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 21:27:29 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 21:27:29 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 21:27:29 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 21:27:29 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 21:27:29 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 21:27:30 INFO - Downloading docopt-0.6.1.tar.gz 21:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:27:30 INFO - Installing collected packages: blobuploader, requests, docopt 21:27:30 INFO - Running setup.py install for blobuploader 21:27:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:27:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:27:30 INFO - Running setup.py install for requests 21:27:30 INFO - Running setup.py install for docopt 21:27:31 INFO - Successfully installed blobuploader requests docopt 21:27:31 INFO - Cleaning up... 21:27:31 INFO - Return code: 0 21:27:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:27:31 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')]} 21:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:31 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')]} 21:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:31 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 0x1037a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a1ccc2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647e00>, '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 0x1034b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103642b20>, '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.xi0FpsdfDB/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.h4x35AdMTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 21:27:31 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 21:27:31 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 21:27:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xi0FpsdfDB/Render', 21:27:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:27:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:27:31 INFO - 'HOME': '/Users/cltbld', 21:27:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:27:31 INFO - 'LOGNAME': 'cltbld', 21:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:27:31 INFO - 'MOZ_NO_REMOTE': '1', 21:27:31 INFO - 'NO_EM_RESTART': '1', 21:27:31 INFO - 'PAGER': '/bin/cat', 21:27:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:27:31 INFO - 'PWD': '/builds/slave/test', 21:27:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:27:31 INFO - 'SHELL': '/bin/bash', 21:27:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h4x35AdMTC/Listeners', 21:27:31 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 21:27:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:27:31 INFO - 'USER': 'cltbld', 21:27:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:27:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:27:31 INFO - 'XPC_FLAGS': '0x0', 21:27:31 INFO - 'XPC_SERVICE_NAME': '0', 21:27:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:27:31 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-9rsQIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:27:31 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-97LszE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:27:31 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Gyvki7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:27:31 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-4qAYXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:27:31 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-kj96MN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:27:32 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-AC7Ugj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:27:32 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-s2LQDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:27:32 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-21AOZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:27:32 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-oErgTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:27:32 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-joXe0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:27:32 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-hPTv2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:27:32 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-fSJV4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:27:32 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-8PM8N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:27:32 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-r05bpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:27:32 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-qqgRCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:27:33 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Aryfvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:27:33 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-pb2m9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:27:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:27:33 INFO - Running setup.py install for manifestparser 21:27:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:27:33 INFO - Running setup.py install for mozcrash 21:27:33 INFO - Running setup.py install for mozdebug 21:27:33 INFO - Running setup.py install for mozdevice 21:27:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:27:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:27:33 INFO - Running setup.py install for mozfile 21:27:34 INFO - Running setup.py install for mozhttpd 21:27:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:27:34 INFO - Running setup.py install for mozinfo 21:27:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:27:34 INFO - Running setup.py install for mozInstall 21:27:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:27:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:27:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:27:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:27:34 INFO - Running setup.py install for mozleak 21:27:34 INFO - Running setup.py install for mozlog 21:27:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:27:34 INFO - Running setup.py install for moznetwork 21:27:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:27:34 INFO - Running setup.py install for mozprocess 21:27:35 INFO - Running setup.py install for mozprofile 21:27:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:27:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:27:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:27:35 INFO - Running setup.py install for mozrunner 21:27:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:27:35 INFO - Running setup.py install for mozscreenshot 21:27:35 INFO - Running setup.py install for moztest 21:27:35 INFO - Running setup.py install for mozversion 21:27:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:27:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:27:35 INFO - Cleaning up... 21:27:35 INFO - Return code: 0 21:27:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:27:35 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')]} 21:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:35 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')]} 21:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:35 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 0x1037a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a1ccc2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647e00>, '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 0x1034b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103642b20>, '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.xi0FpsdfDB/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.h4x35AdMTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 21:27:35 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 21:27:35 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 21:27:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xi0FpsdfDB/Render', 21:27:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:27:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:27:35 INFO - 'HOME': '/Users/cltbld', 21:27:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:27:35 INFO - 'LOGNAME': 'cltbld', 21:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:27:35 INFO - 'MOZ_NO_REMOTE': '1', 21:27:35 INFO - 'NO_EM_RESTART': '1', 21:27:35 INFO - 'PAGER': '/bin/cat', 21:27:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:27:35 INFO - 'PWD': '/builds/slave/test', 21:27:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:27:35 INFO - 'SHELL': '/bin/bash', 21:27:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h4x35AdMTC/Listeners', 21:27:35 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 21:27:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:27:35 INFO - 'USER': 'cltbld', 21:27:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:27:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:27:35 INFO - 'XPC_FLAGS': '0x0', 21:27:35 INFO - 'XPC_SERVICE_NAME': '0', 21:27:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:27:36 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-F5xBB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:27:36 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)) 21:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:27:36 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-WideY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 21:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:27:36 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-UMBfSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:27:36 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)) 21:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:27:36 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-UZ1nUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:27:36 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)) 21:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:27:36 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-7ICL36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:27:36 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)) 21:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:27:36 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-2Vi1To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:27:36 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)) 21:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:27:36 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-aKmeiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:27:36 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)) 21:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:27:36 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Y9u_jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:27:36 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)) 21:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:27:36 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-6RpkQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:27:37 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)) 21:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:27:37 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Z5obCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:27:37 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)) 21:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:27:37 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-L_Al0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:27:37 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)) 21:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:27:37 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-H4HfIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:27:37 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)) 21:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:27:37 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-9ORQhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:27:37 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)) 21:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:27:37 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-AbHbiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:27:37 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)) 21:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:27:37 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-98xZce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:27:37 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)) 21:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:27:37 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-2Dc_cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:27:37 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)) 21:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:27:37 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-gZv_gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:27:37 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)) 21:27:37 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:27:37 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:27:37 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)) 21:27:37 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)) 21:27:37 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)) 21:27:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:27:37 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 21:27:37 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 21:27:37 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 21:27:37 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 21:27:37 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 21:27:37 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 21:27:40 INFO - Downloading blessings-1.6.tar.gz 21:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:27:40 INFO - Installing collected packages: blessings 21:27:40 INFO - Running setup.py install for blessings 21:27:40 INFO - Successfully installed blessings 21:27:40 INFO - Cleaning up... 21:27:40 INFO - Return code: 0 21:27:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:27:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:27:41 INFO - Reading from file tmpfile_stdout 21:27:41 INFO - Current package versions: 21:27:41 INFO - blessings == 1.6 21:27:41 INFO - blobuploader == 1.2.4 21:27:41 INFO - docopt == 0.6.1 21:27:41 INFO - manifestparser == 1.1 21:27:41 INFO - mozInstall == 1.12 21:27:41 INFO - mozcrash == 0.17 21:27:41 INFO - mozdebug == 0.1 21:27:41 INFO - mozdevice == 0.48 21:27:41 INFO - mozfile == 1.2 21:27:41 INFO - mozhttpd == 0.7 21:27:41 INFO - mozinfo == 0.9 21:27:41 INFO - mozleak == 0.1 21:27:41 INFO - mozlog == 3.1 21:27:41 INFO - moznetwork == 0.27 21:27:41 INFO - mozprocess == 0.22 21:27:41 INFO - mozprofile == 0.28 21:27:41 INFO - mozrunner == 6.11 21:27:41 INFO - mozscreenshot == 0.1 21:27:41 INFO - mozsystemmonitor == 0.0 21:27:41 INFO - moztest == 0.7 21:27:41 INFO - mozversion == 1.4 21:27:41 INFO - psutil == 3.1.1 21:27:41 INFO - requests == 1.2.3 21:27:41 INFO - wsgiref == 0.1.2 21:27:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:27:41 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')]} 21:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:41 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')]} 21:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:41 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 0x1037a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a1ccc2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647e00>, '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 0x1034b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103642b20>, '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.xi0FpsdfDB/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.h4x35AdMTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 21:27:41 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 21:27:41 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 21:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xi0FpsdfDB/Render', 21:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:27:41 INFO - 'HOME': '/Users/cltbld', 21:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:27:41 INFO - 'LOGNAME': 'cltbld', 21:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:27:41 INFO - 'MOZ_NO_REMOTE': '1', 21:27:41 INFO - 'NO_EM_RESTART': '1', 21:27:41 INFO - 'PAGER': '/bin/cat', 21:27:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:27:41 INFO - 'PWD': '/builds/slave/test', 21:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:27:41 INFO - 'SHELL': '/bin/bash', 21:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h4x35AdMTC/Listeners', 21:27:41 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 21:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:27:41 INFO - 'USER': 'cltbld', 21:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:27:41 INFO - 'XPC_FLAGS': '0x0', 21:27:41 INFO - 'XPC_SERVICE_NAME': '0', 21:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:27:41 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)) 21:27:41 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)) 21:27:41 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)) 21:27:41 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)) 21:27:41 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)) 21:27:41 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)) 21:27:41 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)) 21:27:41 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)) 21:27:41 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)) 21:27:41 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)) 21:27:41 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)) 21:27:41 INFO - Cleaning up... 21:27:41 INFO - Return code: 0 21:27:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:27:41 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')]} 21:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:41 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')]} 21:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:41 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 0x1037a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a1ccc2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647e00>, '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 0x1034b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103642b20>, '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.xi0FpsdfDB/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.h4x35AdMTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 21:27:41 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 21:27:41 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 21:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xi0FpsdfDB/Render', 21:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:27:41 INFO - 'HOME': '/Users/cltbld', 21:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:27:41 INFO - 'LOGNAME': 'cltbld', 21:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:27:41 INFO - 'MOZ_NO_REMOTE': '1', 21:27:41 INFO - 'NO_EM_RESTART': '1', 21:27:41 INFO - 'PAGER': '/bin/cat', 21:27:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:27:41 INFO - 'PWD': '/builds/slave/test', 21:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:27:41 INFO - 'SHELL': '/bin/bash', 21:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h4x35AdMTC/Listeners', 21:27:41 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 21:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:27:41 INFO - 'USER': 'cltbld', 21:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:27:41 INFO - 'XPC_FLAGS': '0x0', 21:27:41 INFO - 'XPC_SERVICE_NAME': '0', 21:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:27:41 INFO - Downloading/unpacking jsonschema 21:27: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 21:27: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 21:27: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 21:27: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 21:27: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 21:27: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 21:27:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:27:44 INFO - Downloading/unpacking functools32 (from jsonschema) 21:27:44 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 21:27:44 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 21:27:44 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 21:27:44 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 21:27:44 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 21:27:44 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 21:27:44 INFO - Downloading functools32-3.2.3-2.tar.gz 21:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:27:44 INFO - warning: no files found matching '*.txt' 21:27:44 INFO - no previously-included directories found matching 'build' 21:27:44 INFO - no previously-included directories found matching 'dist' 21:27:44 INFO - no previously-included directories found matching '.git*' 21:27:44 INFO - Installing collected packages: jsonschema, functools32 21:27:44 INFO - Running setup.py install for functools32 21:27:44 INFO - warning: no files found matching '*.txt' 21:27:44 INFO - no previously-included directories found matching 'build' 21:27:44 INFO - no previously-included directories found matching 'dist' 21:27:44 INFO - no previously-included directories found matching '.git*' 21:27:44 INFO - Successfully installed jsonschema functools32 21:27:44 INFO - Cleaning up... 21:27:44 INFO - Return code: 0 21:27:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:27:44 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')]} 21:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:44 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')]} 21:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:27:44 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 0x1037a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a1ccc2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647e00>, '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 0x1034b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103642b20>, '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.xi0FpsdfDB/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.h4x35AdMTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 21:27:44 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 21:27:44 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 21:27:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xi0FpsdfDB/Render', 21:27:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:27:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:27:44 INFO - 'HOME': '/Users/cltbld', 21:27:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:27:44 INFO - 'LOGNAME': 'cltbld', 21:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:27:44 INFO - 'MOZ_NO_REMOTE': '1', 21:27:44 INFO - 'NO_EM_RESTART': '1', 21:27:44 INFO - 'PAGER': '/bin/cat', 21:27:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:27:44 INFO - 'PWD': '/builds/slave/test', 21:27:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:27:44 INFO - 'SHELL': '/bin/bash', 21:27:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h4x35AdMTC/Listeners', 21:27:44 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 21:27:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:27:44 INFO - 'USER': 'cltbld', 21:27:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:27:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:27:44 INFO - 'XPC_FLAGS': '0x0', 21:27:44 INFO - 'XPC_SERVICE_NAME': '0', 21:27:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:27:45 INFO - Downloading/unpacking flake8 21:27:45 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 21:27:45 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 21:27:45 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 21:27:45 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 21:27:45 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 21:27:45 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 21:27:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:27:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:27:47 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 21:27:47 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 21:27:47 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 21:27:47 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 21:27:47 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 21:27:47 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 21:27:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:27:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:27:47 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 21:27:47 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 21:27:47 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 21:27:47 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 21:27:47 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 21:27:47 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 21:27:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:27:48 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 21:27:48 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 21:27:48 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 21:27:48 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 21:27:48 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 21:27:48 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 21:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:27:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:27:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:27:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:27:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:27:48 INFO - no previously-included directories found matching 'docs/_build' 21:27:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:27:48 INFO - Running setup.py install for pep8 21:27:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:27:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:27:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:27:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:27:49 INFO - no previously-included directories found matching 'docs/_build' 21:27:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:27:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:27:49 INFO - Cleaning up... 21:27:49 INFO - Return code: 0 21:27:49 INFO - Running post-action listener: _resource_record_post_action 21:27:49 INFO - Running post-action listener: _start_resource_monitoring 21:27:49 INFO - Starting resource monitoring. 21:27:49 INFO - ##### 21:27:49 INFO - ##### Running install step. 21:27:49 INFO - ##### 21:27:49 INFO - Running pre-action listener: _resource_record_pre_action 21:27:49 INFO - Running main action method: install 21:27:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:27:49 INFO - Reading from file tmpfile_stdout 21:27:49 INFO - Detecting whether we're running mozinstall >=1.0... 21:27:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:27:49 INFO - Reading from file tmpfile_stdout 21:27:49 INFO - Output received: 21:27:49 INFO - Usage: mozinstall [options] installer 21:27:49 INFO - Options: 21:27:49 INFO - -h, --help show this help message and exit 21:27:49 INFO - -d DEST, --destination=DEST 21:27:49 INFO - Directory to install application into. [default: 21:27:49 INFO - "/builds/slave/test"] 21:27:49 INFO - --app=APP Application being installed. [default: firefox] 21:27:49 INFO - mkdir: /builds/slave/test/build/application 21:27:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:28:23 INFO - Reading from file tmpfile_stdout 21:28:23 INFO - Output received: 21:28:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:28:23 INFO - Running post-action listener: _resource_record_post_action 21:28:23 INFO - ##### 21:28:23 INFO - ##### Running run-tests step. 21:28:23 INFO - ##### 21:28:23 INFO - Running pre-action listener: _resource_record_pre_action 21:28:23 INFO - Running main action method: run_tests 21:28:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:28:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:28:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:28:23 INFO - 2016-04-13 21:28:23.599 screenresolution[1642:7431] starting screenresolution argv=screenresolution get 21:28:23 INFO - 2016-04-13 21:28:23.601 screenresolution[1642:7431] Display 0: 1600x1200x32@60 21:28:23 INFO - 2016-04-13 21:28:23.607 screenresolution[1643:7433] starting screenresolution argv=screenresolution list 21:28:23 INFO - Available Modes on Display 0 21:28:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:28:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:28:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:28:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:28:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:28:23 INFO - Intel Iris: 21:28:23 INFO - Chipset Model: Intel Iris 21:28:23 INFO - Type: GPU 21:28:23 INFO - Bus: Built-In 21:28:23 INFO - VRAM (Dynamic, Max): 1536 MB 21:28:23 INFO - Vendor: Intel (0x8086) 21:28:23 INFO - Device ID: 0x0a2e 21:28:23 INFO - Revision ID: 0x0009 21:28:23 INFO - Displays: 21:28:23 INFO - Display: 21:28:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:28:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:28:23 INFO - Display Serial Number: 1600x1200 60 21:28:23 INFO - Main Display: Yes 21:28:23 INFO - Mirror: Off 21:28:23 INFO - Online: Yes 21:28:23 INFO - Rotation: Supported 21:28:23 INFO - Return code: 0 21:28:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:28:23 INFO - Python 2.7.3 21:28:23 INFO - Return code: 0 21:28:23 INFO - grabbing minidump binary from tooltool 21:28:23 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')]} 21:28:23 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 0x103647e00>, '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 0x1034b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103642b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:28:23 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 21:28:23 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 21:28:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:28:23 INFO - Return code: 0 21:28:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:28:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:28:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:28:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:28:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:28:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:28:25 INFO - Return code: 0 21:28:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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 21:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0116 --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 21:28:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xi0FpsdfDB/Render', 21:28:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:28:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:28:25 INFO - 'HOME': '/Users/cltbld', 21:28:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:28:25 INFO - 'LOGNAME': 'cltbld', 21:28:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:28:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:25 INFO - 'MOZ_NO_REMOTE': '1', 21:28:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:28:25 INFO - 'NO_EM_RESTART': '1', 21:28:25 INFO - 'PAGER': '/bin/cat', 21:28:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:25 INFO - 'PWD': '/builds/slave/test', 21:28:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:28:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:28:25 INFO - 'SHELL': '/bin/bash', 21:28:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h4x35AdMTC/Listeners', 21:28:25 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 21:28:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:28:25 INFO - 'USER': 'cltbld', 21:28:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:28:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:25 INFO - 'XPC_FLAGS': '0x0', 21:28:25 INFO - 'XPC_SERVICE_NAME': '0', 21:28:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:28:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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 21:28:25 INFO - mozversion application_buildid: 20160413184655 21:28:25 INFO - mozversion application_changeset: f6fe48816b24556b76f34e7e3ec9713a439bb191 21:28:25 INFO - mozversion application_display_name: Nightly 21:28:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:28:25 INFO - mozversion application_name: Firefox 21:28:25 INFO - mozversion application_remotingname: firefox 21:28:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:28:25 INFO - mozversion application_vendor: Mozilla 21:28:25 INFO - mozversion application_version: 48.0a1 21:28:25 INFO - mozversion platform_buildid: 20160413184655 21:28:25 INFO - mozversion platform_changeset: f6fe48816b24556b76f34e7e3ec9713a439bb191 21:28:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:28:25 INFO - mozversion platform_version: 48.0a1 21:28:25 INFO - using testdate: 1460608105 21:28:25 INFO - actual date: 1460608105 21:28:25 INFO - starting webserver on 'localhost:49279' 21:28:25 INFO - SUITE-START | Running 2 tests 21:28:25 INFO - TEST-START | dromaeo_css 21:28:25 INFO - operating with platform_type : mac_ 21:28:25 INFO - Initialising browser for dromaeo_css test... 21:28:25 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpMg7hhU/profile http://localhost:49279/getInfo.html) 21:28:27 INFO - PROCESS | 1661 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 21:28:28 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 21:28:28 INFO - PROCESS | 1661 | colorDepth:24 21:28:28 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 21:28:28 INFO - PROCESS | 1661 | __metrics 21:28:28 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 21:28:28 INFO - TEST-INFO | 1661: exit 0 21:28:28 INFO - Browser initialized. 21:28:28 INFO - Running cycle 1/1 for dromaeo_css test... 21:28:28 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpMg7hhU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:28:40 INFO - PROCESS | 1664 | RSS: Main: 248049664 21:28:40 INFO - PROCESS | 1664 | 21:29:30 INFO - PROCESS | 1664 | 1460608170555 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] 21:31:41 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 21:31:42 INFO - PROCESS | 1664 | RSS: Main: 260612096 21:31:42 INFO - PROCESS | 1664 | 21:34:44 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 21:34:45 INFO - PROCESS | 1664 | RSS: Main: 272719872 21:34:45 INFO - PROCESS | 1664 | 21:37:47 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 21:37:48 INFO - PROCESS | 1664 | RSS: Main: 273637376 21:37:48 INFO - PROCESS | 1664 | 21:40:49 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 21:40:50 INFO - PROCESS | 1664 | RSS: Main: 275243008 21:40:50 INFO - PROCESS | 1664 | 21:43:53 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 21:43:53 INFO - PROCESS | 1664 | RSS: Main: 278089728 21:43:53 INFO - PROCESS | 1664 | 21:46:56 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 21:46:56 INFO - PROCESS | 1664 | RSS: Main: 279318528 21:46:56 INFO - PROCESS | 1664 | 21:46:56 INFO - PROCESS | 1664 | __start_tp_report 21:46:56 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 21:46:56 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 21:46:56 INFO - PROCESS | 1664 | |i|pagename|runs| 21:46:56 INFO - PROCESS | 1664 | |0;dojo.html;3479.495473156393;3492.563429571303;3517;3522.9471557926618;3556.5554305711785;5860.384659610738;5906.822795316137;5928.644281343117;5945.791897283596;5952.851178720529;5785.884282314351;5910.379410161936;5914.822555323336;5990.131430942511;6060.606060606068;5170.508801663846;5272.31459910213;5290.2064690296575;5303.257543943851;5344.7862085516535;340.05059739588523;4108.4453598764085;5267.28891599633;5294.2058691196435;5344.5724342052545;5193.792248310063;5251.369835619712;5257.684538927658;5261.579073674096;5288.103764302813;4530.478994915594;5121.4110377306715;5360.195970604402;5365.892682146375;5388.353397592275;4301.225779359714;5163.7159956202395;5188.662736922088;5250.894982100374;5281.313429254173;5602.831915042555;5694.914576281359;5744.626599271034;5771;5810.099434587646;6145.095020543601;6178.876422471525;6255.655938923357;6281.120643109968;6304.022876454157;6227.719752611143;6246.969250073777;6279.026750853625;6297.811065668037;6310.5267104967315;5957.970210148965;5969.880602387928;5985.910211346833;6012.699365031731;6075.058365953284;5423.566114710814;6223.439890409885;6314.926462501386;6353.205849268841;6357.300696923335;6212.81361559154;6218.098375735493;6224.533160013018;6253.874922501615;6286.308506064329;6224.688765561704;6234.407731265614;6263.78076767311;6270.153529273581;6284.465820405317;6145.508359331243;6181.660008699475;6219.346968568326;6254.781082662176;6285.748570057238;6108.6029408089225;6197.411245931629;6260.342664020212;6276.089966954766;6280.371962803683;4225.345071513921;4954.900901982012;5011.6241281904;5014.924776128361;5025.14572522672;4377.146456440963;4450.532694067141;4497.168023915586;4514;4542.772861356919;5980.252468441445;6019.54853385989;6027.156198132265;6056;6057.303410107894;6309.810705678837;6315.210598675166;6325.3674632537295;6328.778492752732;6330.905036424458;5865.824025279248;5949.530944658005;5983.1623572699855;6076.0885867119405;6083.8174854754425;5498.532624726863;5498.5876059295715;5501.339839219239;5507.339119305709;5508.697021663847;6487.18910136233;6493.480521558264;6494.350564943562;6497.382748638872;6505.121808555879;6173.536984726254;6224.844378890564;6254.562180647311;6290.685465726787;6312.747490100344;6419.646919419477;6424.935750642434;6466.644334561456;6476;6484.319146489551;6119.715820550657;6208.2239720034995;6234.688265586793;6239.719212635351;6267.2165979252595;4966.106100901728;5052.216906379517;5997.430244126801;6259.530535209787;6262.499000079892;6242.719077641426;6257.624542527463;6258.624482531062;6280.0893870389455;6284.528660350584;5115.462876398074;6028.788992385421;6213.37866213375;6253.405926436982;6282.246130464374;4526.796294166705;4961.2806143109765;5393.919091213556;6109.11417844419;6113.29697084841;5262.473752624707;5986.580939334205;6124.081387791867;6200.131981522681;6218.06728990655;5385.434529374516;5977.402259773988;6083.482903953213;6132.41742034506;6136.417040381157 21:46:56 INFO - PROCESS | 1664 | |1;ext.html;483.8717739798953;529.6504307157275;547.6495043172371;548.6570893191754;592.1946153231602;36484.63515364846;37210.44184337237;37227;37245.813770931105;37278.813605931966;39474;40034.79982600083;40378.79810600943;40426.39360409596;40563.797181014124;7709.922900770991;9549.570269337863;9551.99704031077;9583.424994500352;9635.13283804461;9525.047495250488;9574.90425095747;9595;9643.517824108802;9667.903320966805;9555.092266234697;9581.520923953809;9622.278329125309;9628.759281017996;9667;9571.760705982337;9572.282078844044;9583.856242156373;9632.47021413822;9653.986331435239;8397.992240931128;9465.195458385977;9467.66863159786;9484.19384352331;9537.570809313598;36670.449943250875;37097.81451092754;37206;37299;37460.625393745984;2768.224897028815;3030.681778413257;3135.937281254362;3362.1258472797003;3388.881389151368;25475.61786573203;25669.871650641628;25737;26350.86824565884;26935.32661683454;2645.6031595260865;2679.9866000670067;2720.7551320381062;2722.992492777665;2774.9861250693616;247174;302003;303750;314440;316514;32281.51577726336;32509.024729257686;32653.183670407954;32663.183420414203;32680.509792353132;51715.48284517182;65594.67202664052;65700;66211;66347.66826165839;16003.519894403187;16024.75962860558;16228.756568651479;16295.022298661881;16615.916920415322;12342.197757145757;12491.125621206611;12573.748525029449;12599.118061735591;12757.55348562796;19051.237950482104;19175;19190;19201.903990479957;19483.8051619482;8142;8259.587020648944;8286.337093032664;8301.916980830236;8326.916730832736;842.6671464771381;923.5013092929877;1075.510642657589;1075.58589942871;1085.159001773616;22949;29244.85377573141;29673.387735699725;29845.95539156119;29860.55209171864;1050.2753100360878;1088.374184843718;1115.0800589513683;1170.3621526268205;1193.785118678646;14593.92703036478;14664;14928;15287.617809554627;15365.231738413035;618901;635321;635644;638412;639016;57325;58348;58923;58961.70519147377;59184.70407647934;1404.7471455138173;1416.5113036002563;1439.0933711761522;1467.1270593996555;1469.1332114052973;25049.499010020063;29194.270143246587;29515.704842951294;29738.553921691626;29831;49541.25688114609;49674.75162624164;50293;50510.74744626253;50675;564191;567714;569259;570200;570402;25765.871170644026;31544.211394715316;42014;42062.57937420587;42157.57842421659;42997.785011074746;43646.12707745891;43788;43953;44526.3321050191;35814.4627830588;36016;36052.45921311235;36788.63211367959;36953;31874;35890.820545897106;36090.63909360873;36916.44625330569;37035.62964370322;35354.29291414106;35497.645023549434;35680.7511737088;35924.101897452776;36068.63931360653;26973.46053078888;31471.47027666811;31820.68179318177;31829.840850795597;31884.202894927814;21038.68441973402;22901.77098229063;23691.881540592185;24158.154464593656;24581.385465362793 21:46:56 INFO - PROCESS | 1664 | |2;jquery.html;329.78728719975607;352.4167502782894;352.46425433341307;384.7479900665064;392.78789453695026;20297;20510.179592816286;20921;21670.458238544063;21867.343979680594;17291.913540432313;20664.276750313744;21064.789352106476;21294.041768120434;21563.892180539115;4635.327877457767;5736.541076713864;5891.617044892089;5986.132010858423;6589.406953374195;6413.807585772434;6435.034744788272;6482.319356467574;6496.57772244805;6498.415142637162;6005.819825405245;6406.807795766134;6414.422701956823;6417.6149431034055;6430.099786029959;5480.6437581557075;5701.572382071361;5902.704864756788;6290.182276304097;6368.777092801753;5204.141316682781;5455.972720136414;5642.548596112301;5663.66018038919;5777.5666824987875;11582.942085289604;13237.86762132376;13475.663108422368;13539.39072741729;14831.48089816862;2013;2041.469218003315;2069.3584988653565;2098.234144537248;2127.1172463427815;9724.270679699051;9839.852402213972;9874.654387096418;9907.702768916944;10185.185185185168;1679.4541773923402;1780.64387122576;1810.185416562552;1823.3618233618126;1843.4377514857963;118002;122395.38802306021;122819.54360912822;125307.3734631321;126698;11711.648650540497;11715.25585987151;11726.589569365031;11731.120165987584;11829.940850295865;14996.325165367585;15007.324670389859;15020.624484387978;15058.924705376403;15111.244437778067;8613.69852055175;8645.178708022853;8696.78258043554;8737.825243495094;8807.91192088071;8308.086110527836;8524.95737521321;8527.74416767498;8552.486850788848;8653;4554.544545545486;4559.247724125482;4637.1421287062;4654.868490504025;4712.64655150865;1941.708743688458;2007.427883053352;2009.0657844102564;2009.1360714892737;2020.2928974858683;902.264654306738;950.9572069256761;954.8090381923643;1007.8034783217349;1047.638564695179;20443.897780511;20752;20818.79181208199;21027.68458473124;21056;954.613381580461;955.507913424587;976.097110173087;979.1432496565506;1031.376017509411;10749.892501075046;11033.951774581403;11044;11079.889201108046;11098.889011109786;580525;599578;600273;613519;617476;130084;131123;133088;134835.32582337025;135441.3227933854;1000.849872519128;1026.8151732688189;1033.0599154769275;1050.0706874416044;1054.920880933933;14296.356663950355;16777.32890684408;17673.64652706913;18168.182431790865;18598.884066956027;35364;48659.51340486691;49682.75158624184;50802.74598626983;51119;69425;75071.49857002939;76161;76686.61656691681;76995.61502192453;7434.7769566913075;7747.18654541265;7948.8807667886185;7959.801004974922;8176.264136227768;10128.594856205964;11485.942570287096;12359.814602781145;12673.239605623692;12834.037447191684;10228.31232846572;10352.17182625373;10744.677659670222;10840.45797710127;11345.149113816331;10652.89347106519;10680.89319106799;11051.557937682725;11164.888351116384;11265.493052812806;10723.517441714985;10868.565257389615;10915.345079295268;10941.56233750641;11118.777624447304;6872.62200578973;7945.20547945224;8027.438079334391;8063.83872322562;8338.833223335378;8213.630386632496;9041;10386.37681739068;11184.608538701106;11256.887431125911 21:46:56 INFO - PROCESS | 1664 | |3;mootools.html;1302.9478820847166;1510.131674287285;1586.7699183618367;1736.8263173682633;1835.559465728224;7467.9918211041495;8084.070331911832;8687.652493900236;8799.868001979967;8903.91096089039;8618.95690521548;8623.310135189186;8659.047504774486;8696.608652610632;8783.429077109984;2419.3104965084954;2441.914532991346;2444.6699695541142;2452.3010941881566;2452.9386765330833;2132.8400369972314;2284.132029828663;2417.4319035026756;2428.089466450081;2469.1604854349516;2240.820734341257;2448.608222684371;2471.938201544958;2483.7640424159677;2484.043643197373;2436.0377650827822;2454.1287842815723;2459.963100553493;2459.9754002459927;2476.727559968402;2433.221369161869;2433.3551608823677;2443.438009257863;2462.5198086373166;2466.6300054991893;8829.117088291183;8867.955660221722;8881.978572464184;8978.191962723386;8991.730248092568;5271.262023316739;5362.302900622933;5398.541124004464;5491.28613280275;5521.337439507285;3615.584207816082;3639.581448133472;3642.435422509489;3647.8723244686307;3661.5972243053243;1035.0580971316142;1055.5091882274703;1056.1023130339227;1074.462768615692;1096.1723898456694;11457;11494;11549.076073914066;11558.884411155865;11566.90114439127;4794.712317260975;4849.636277279218;4880.389951256093;4925.13810083234;5002.674826136289;9884.357516761387;9944.30389872702;9961.501924903725;9981.700548983543;9982.650607228712;5352.759125839347;5387.299651045418;5413.918791218135;5456.454354564512;5464.535514481234;4448.688591798607;4828.565429111397;4949.90100197994;4965.751712414437;4988.90022199554;4077.2049450356894;4093.752474463508;4122.56713045132;4151.584841515824;4187.413762073312;1331.391927875449;1354.2754626274896;1364.3382959264748;1372.4235820955223;1374.6425929258464;845.2857335551572;858.5921687198655;869.8341130584798;888.7422647432302;948.3740731117567;5882.882342353129;5932.228810254639;5985.730642121115;6109.602875813058;6191.288001879751;818.9672413103528;951.3863558005187;957.4303289542711;972.2805124208035;995.8456439251928;3868.516435445569;4000.179963107556;4015.859444919414;4041.7372870763306;4049.3521036633997;10224.897751022394;10703.571857125628;10725.78548429027;10747.086497647788;10829.783404331869;9794.167495762798;10128.59485620567;10636.46817659114;10655.200859935381;10924.781504370027;6998.335158159966;7089.468289878177;8148.26665600087;8168.060673022678;8182.672693092329;4894.681845680019;5928.170056192051;5959.523238141025;6040.426159515015;6065.272167339947;9478.336516443782;9602.375845570015;9702.9029709702;9719.271054670786;9739.41563506192;8106.635201416068;8947.19475247231;9563.808723825345;9831.85252221203;10087.69736907894;6939.30606939302;7309.013283206699;7499.662515186938;7548.698052078075;7571;8245.257926786619;8257.917420825715;8294.792630184294;8298.377621678519;8305.584720764058;7211.134663840163;7328.047353843966;7362.779116626296;7454.993575867188;7510.962445187739;6372.617642941438;7185;7322.560646361236;7333.266673332624;7348.632568371667;6983.1620205575655;7024.26245244242;7068.823279418056;7081.114860642419;7081.150261968597;4872.634552408513;4944.950550494449;4963.429205641398;5034.16936205522;5161.793528258978;4782.856514304437;4942.950570494249;5010.223415370623;5163.535281824654;5242.16125419931 21:46:56 INFO - PROCESS | 1664 | |4;prototype.html;311.20487155318165;318.7816345803125;320.2937522762309;328.3252915259142;329.6752698591888;4621.953780462203;5102.744862756866;5172.560332371748;5832.1834943108;5962.807438512298;4651.837185698501;5182.2016111299945;6030.608010479315;6065.332813390523;6066.757329706807;4254.574717469636;4448.510663826976;4496;4501.189785838547;4519.4124763780665;3823.9044023899346;4168.5623009584015;4454.37638730578;4456.5766252205985;4487.3717679524725;3902.6487616114546;4129.6283334499885;4410.140022695576;4419.845305414311;4423.977880110611;4194.266003449415;4390.714603550759;4426.22541055314;4442.911141777146;4445.51099379068;3398.9633161885613;3666.4866918631415;3788.7916164610933;3792.829322680486;3823.1780167264174;5066.493350664941;5069.493050694938;5726.484616384504;5743.59794814359;5753.769849206027;4916.385451818523;5095.184770436749;5119.462456442057;5129.871753206163;5136.101182293121;5251.92335571207;5746.683932383718;6202.751889924398;6337.176167098294;6383.170187875593;3537.284417057725;3572.392693242129;4207;4214.7681877496725;4233.343831706091;5613.494785469327;5770.509506691937;6459.479583626935;6665.800025999228;6734.158230221223;3743.435746513647;4157.835805974332;4251.320728312299;4266.1254442839145;4288.185244803477;4325.329573916048;4334.1981733379425;4353.0423306872435;4356.433663623772;4365.323374876899;4452;5107.901801112778;5119.950410165981;5145.228215767665;5149.639525233272;5703.287089113861;5850.473457388855;6219.502439804804;6406.583572067801;6408.743650253938;1241.5778635263873;1344.7781116115927;1417.0080943339703;1503.518873960344;1510.6903084867795;875.5140896802336;889.5418859287472;977.0327375897951;984.5618699678718;995.6216637677636;5548.306461692288;5906.468417842415;5966.970165149147;5990.371011043778;6012.849678757979;5843.737031833492;6082.422169893853;6644.568103073285;6645.900311495331;6697.799066028027;5416.2688037114485;5950.940490595125;6095.329513753483;6098.6762214593155;6137.324894261627;3433.7939723616664;3508.2808024354945;3550.6981906537717;3567.2152126532123;3569.3575156472084;6195.938040619626;6524.282328943812;6979.267176946449;6979.6859141337745;7021.89467157993;5554.444555544494;6909.30906909305;6914.965425172943;6936.79189624312;6943.409810166091;6643.335666433318;6846.897296540656;7023.33278338557;7029.824254393681;7055;6711.4966377520905;6720.8319792005595;6721.395074443323;6745.628990405575;6750.729970801113;6452.709628066655;6576.967115164393;6613.933860661525;6639.402453779183;6641.867162656623;6938.167419909643;6961.965190174219;6990.370866622028;7000.369966703021;7001.844695625368;3669.6146904575703;4268.679849011399;4313.61177494027;4314.439122914001;4330.372096046119;5507.108767896886;6340.365963403808;6485.929821579387;6498.545101842826;6664.500487390298;6462.612243265231;6476.643784591704;6490.221173459215;6498.707558159988;6501.577397469149;6210.968945155245;6432.13166222554;6449.097126402401;6457;6460.709268082854;5050.292958985819;6102.969485152724;6263.592866463848;6299.086632438362;6338.271098823694;5554;6306.558540902093;6477.708503117466;6481.805545833632;6499.350064993463;6054.48536874353;6276.435120839146;6326.493880489642;6328.588641738273;6328.936710633019 21:46:56 INFO - PROCESS | 1664 | |5;yui.html;727.2218725963219;740.8296091898864;744.5086243079569;763.1681467200751;778.0546635837457;14851.851481485182;14966.102033877974;15177.241137943114;15485.993410428327;15545.300461479246;11845.822312665317;13796.310184490785;13797.724045519084;14100.858991410083;14265.71468570628;711.2283172757565;883.6553744039829;890.1410139215656;898.2723993565234;901.5717534171282;900.3832374823266;913.6162811619103;917.6146018672174;918.3571499950028;922.9769255768626;947.5072962059725;955.5126885288519;957.3346524165707;968.2254196642658;973.8149751547219;933;954.8710924025272;960.3133759362055;970.2965350121176;973.5473005052613;695.6452209373256;695.9826004349881;701.8385771272585;705.1573369823063;721.5598484924192;14876.181810000446;15065.623359416102;15122.54632361031;15159.62100947474;15204.239788010555;12850.164739291917;12932.48270069196;13035.86964130356;13065.542706005244;13203.86796132036;10101.797964040752;10108.797824043551;10199.490025498695;10293.073623373932;10594.947025264824;3286.802791832498;3501.4922836188866;3559.857605695795;3571.982140089283;3610.2238018825815;81765;81975;84456.57771711164;85250.57374713087;85319.57340213259;7716.614169291513;9512.619495220113;9539.284553658503;9672.903270967341;9764.755881103029;22657;22832.31503054911;22848.428789280402;22869.88565057164;22889.96995135223;5757.942420575824;7518.097828260535;7523.661435235427;7537.434692398092;7559.962200188964;3911.491506104245;4030.778307193074;4040.454538637305;4048.4534587830854;4058.1477889642915;3115.813051216934;3645.7265705072227;3657.104009517685;3669.669729724284;3708.925821483609;572.9054705973467;649.4577028181427;653.5523166630778;657.980260592183;662.7912207654573;501.12053346377604;530.4032962916718;554.2932760730021;565.2849145830528;592.380961894821;7920.089189743138;7963.098081939807;8030.19698030204;8081.676732930735;8088.433809633269;439.5999640327287;500.78215976050535;582.0657844160147;595.4521839907296;621.6487684458267;3643.6720695137565;4082.4896887889013;4128.318827393447;4204.62158405745;4275.700700950903;73157;74225;79381.80927286095;79417;79908.60045699851;57009;57638.7118064407;60220.096698549554;63432.04851927225;74841;69466;70818.64590677117;71187.64406177936;71221.64389178022;71620.28379716241;8165.632546535539;8271.2142346477;8345.833083338177;8405.075441701285;8463.026751923362;42394;42455.575444246395;43214.56785432105;43751.56248437602;44966.550334496234;57983.420165797805;62139.689301553204;62643;63011;63909.68045159744;10877.564897404016;10926.945365273123;10935.781284374109;11188;11310.92546208109;11899.048076153715;12034.63896083119;12056.819147712968;12137.332446715161;12489;11229;11428.142889283503;11760;11874.52501899949;11949.462274197856;11565.7108572283;11733.706657333634;11818.940905295418;11962.282263064244;11985.580504682293;11282.774344513227;11301.434928253719;11333.613126286324;11521;11878.524859005543;9650.71047868565;9809.313348065853;10018.248631352824;10030.64892728751;10239.078482936273;7833;9748;9779.706608801747;9782.9021709782;9909.752256193364 21:46:56 INFO - PROCESS | 1664 | __end_tp_report 21:46:56 INFO - PROCESS | 1664 | __start_cc_report 21:46:56 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,377 21:46:56 INFO - PROCESS | 1664 | __end_cc_report 21:46:56 INFO - PROCESS | 1664 | __startTimestamp1460609216429__endTimestamp 21:46:56 INFO - PROCESS | 1664 | 21:46:56 INFO - PROCESS | 1664 | ------- Summary: start ------- 21:46:56 INFO - PROCESS | 1664 | Number of tests: 6 21:46:56 INFO - PROCESS | 1664 | 21:46:56 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5736.67 Median:6056.00 stddev:804.04 (13.3%) stddev-sans-first:786.76 21:46:56 INFO - PROCESS | 1664 | Values: 3479.5 3492.6 3517.0 3522.9 3556.6 5860.4 5906.8 5928.6 5945.8 5952.9 5785.9 5910.4 5914.8 5990.1 6060.6 5170.5 5272.3 5290.2 5303.3 5344.8 340.1 4108.4 5267.3 5294.2 5344.6 5193.8 5251.4 5257.7 5261.6 5288.1 4530.5 5121.4 5360.2 5365.9 5388.4 4301.2 5163.7 5188.7 5250.9 5281.3 5602.8 5694.9 5744.6 5771.0 5810.1 6145.1 6178.9 6255.7 6281.1 6304.0 6227.7 6247.0 6279.0 6297.8 6310.5 5958.0 5969.9 5985.9 6012.7 6075.1 5423.6 6223.4 6314.9 6353.2 6357.3 6212.8 6218.1 6224.5 6253.9 6286.3 6224.7 6234.4 6263.8 6270.2 6284.5 6145.5 6181.7 6219.3 6254.8 6285.7 6108.6 6197.4 6260.3 6276.1 6280.4 4225.3 4954.9 5011.6 5014.9 5025.1 4377.1 4450.5 4497.2 4514.0 4542.8 5980.3 6019.5 6027.2 6056.0 6057.3 6309.8 6315.2 6325.4 6328.8 6330.9 5865.8 5949.5 5983.2 6076.1 6083.8 5498.5 5498.6 5501.3 5507.3 5508.7 6487.2 6493.5 6494.4 6497.4 6505.1 6173.5 6224.8 6254.6 6290.7 6312.7 6419.6 6424.9 6466.6 6476.0 6484.3 6119.7 6208.2 6234.7 6239.7 6267.2 4966.1 5052.2 5997.4 6259.5 6262.5 6242.7 6257.6 6258.6 6280.1 6284.5 5115.5 6028.8 6213.4 6253.4 6282.2 4526.8 4961.3 5393.9 6109.1 6113.3 5262.5 5986.6 6124.1 6200.1 6218.1 5385.4 5977.4 6083.5 6132.4 6136.4 21:46:56 INFO - PROCESS | 1664 | 21:46:56 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:63083.47 Median:36287.64 stddev:139606.34 (384.7%) stddev-sans-first:139918.85 21:46:56 INFO - PROCESS | 1664 | Values: 483.9 529.7 547.6 548.7 592.2 36484.6 37210.4 37227.0 37245.8 37278.8 39474.0 40034.8 40378.8 40426.4 40563.8 7709.9 9549.6 9552.0 9583.4 9635.1 9525.0 9574.9 9595.0 9643.5 9667.9 9555.1 9581.5 9622.3 9628.8 9667.0 9571.8 9572.3 9583.9 9632.5 9654.0 8398.0 9465.2 9467.7 9484.2 9537.6 36670.4 37097.8 37206.0 37299.0 37460.6 2768.2 3030.7 3135.9 3362.1 3388.9 25475.6 25669.9 25737.0 26350.9 26935.3 2645.6 2680.0 2720.8 2723.0 2775.0 247174.0 302003.0 303750.0 314440.0 316514.0 32281.5 32509.0 32653.2 32663.2 32680.5 51715.5 65594.7 65700.0 66211.0 66347.7 16003.5 16024.8 16228.8 16295.0 16615.9 12342.2 12491.1 12573.7 12599.1 12757.6 19051.2 19175.0 19190.0 19201.9 19483.8 8142.0 8259.6 8286.3 8301.9 8326.9 842.7 923.5 1075.5 1075.6 1085.2 22949.0 29244.9 29673.4 29846.0 29860.6 1050.3 1088.4 1115.1 1170.4 1193.8 14593.9 14664.0 14928.0 15287.6 15365.2 618901.0 635321.0 635644.0 638412.0 639016.0 57325.0 58348.0 58923.0 58961.7 59184.7 1404.7 1416.5 1439.1 1467.1 1469.1 25049.5 29194.3 29515.7 29738.6 29831.0 49541.3 49674.8 50293.0 50510.7 50675.0 564191.0 567714.0 569259.0 570200.0 570402.0 25765.9 31544.2 42014.0 42062.6 42157.6 42997.8 43646.1 43788.0 43953.0 44526.3 35814.5 36016.0 36052.5 36788.6 36953.0 31874.0 35890.8 36090.6 36916.4 37035.6 35354.3 35497.6 35680.8 35924.1 36068.6 26973.5 31471.5 31820.7 31829.8 31884.2 21038.7 22901.8 23691.9 24158.2 24581.4 21:46:56 INFO - PROCESS | 1664 | 21:46:56 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:34775.02 Median:21060.39 stddev:100764.68 (478.5%) stddev-sans-first:101014.16 21:46:56 INFO - PROCESS | 1664 | Values: 329.8 352.4 352.5 384.7 392.8 20297.0 20510.2 20921.0 21670.5 21867.3 17291.9 20664.3 21064.8 21294.0 21563.9 4635.3 5736.5 5891.6 5986.1 6589.4 6413.8 6435.0 6482.3 6496.6 6498.4 6005.8 6406.8 6414.4 6417.6 6430.1 5480.6 5701.6 5902.7 6290.2 6368.8 5204.1 5456.0 5642.5 5663.7 5777.6 11582.9 13237.9 13475.7 13539.4 14831.5 2013.0 2041.5 2069.4 2098.2 2127.1 9724.3 9839.9 9874.7 9907.7 10185.2 1679.5 1780.6 1810.2 1823.4 1843.4 118002.0 122395.4 122819.5 125307.4 126698.0 11711.6 11715.3 11726.6 11731.1 11829.9 14996.3 15007.3 15020.6 15058.9 15111.2 8613.7 8645.2 8696.8 8737.8 8807.9 8308.1 8525.0 8527.7 8552.5 8653.0 4554.5 4559.2 4637.1 4654.9 4712.6 1941.7 2007.4 2009.1 2009.1 2020.3 902.3 951.0 954.8 1007.8 1047.6 20443.9 20752.0 20818.8 21027.7 21056.0 954.6 955.5 976.1 979.1 1031.4 10749.9 11034.0 11044.0 11079.9 11098.9 580525.0 599578.0 600273.0 613519.0 617476.0 130084.0 131123.0 133088.0 134835.3 135441.3 1000.8 1026.8 1033.1 1050.1 1054.9 14296.4 16777.3 17673.6 18168.2 18598.9 35364.0 48659.5 49682.8 50802.7 51119.0 69425.0 75071.5 76161.0 76686.6 76995.6 7434.8 7747.2 7948.9 7959.8 8176.3 10128.6 11485.9 12359.8 12673.2 12834.0 10228.3 10352.2 10744.7 10840.5 11345.1 10652.9 10680.9 11051.6 11164.9 11265.5 10723.5 10868.6 10915.3 10941.6 11118.8 6872.6 7945.2 8027.4 8063.8 8338.8 8213.6 9041.0 10386.4 11184.6 11256.9 21:46:56 INFO - PROCESS | 1664 | 21:46:56 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5679.99 Median:5256.71 stddev:3103.62 (59.0%) stddev-sans-first:3094.89 21:46:56 INFO - PROCESS | 1664 | Values: 1302.9 1510.1 1586.8 1736.8 1835.6 7468.0 8084.1 8687.7 8799.9 8903.9 8619.0 8623.3 8659.0 8696.6 8783.4 2419.3 2441.9 2444.7 2452.3 2452.9 2132.8 2284.1 2417.4 2428.1 2469.2 2240.8 2448.6 2471.9 2483.8 2484.0 2436.0 2454.1 2460.0 2460.0 2476.7 2433.2 2433.4 2443.4 2462.5 2466.6 8829.1 8868.0 8882.0 8978.2 8991.7 5271.3 5362.3 5398.5 5491.3 5521.3 3615.6 3639.6 3642.4 3647.9 3661.6 1035.1 1055.5 1056.1 1074.5 1096.2 11457.0 11494.0 11549.1 11558.9 11566.9 4794.7 4849.6 4880.4 4925.1 5002.7 9884.4 9944.3 9961.5 9981.7 9982.7 5352.8 5387.3 5413.9 5456.5 5464.5 4448.7 4828.6 4949.9 4965.8 4988.9 4077.2 4093.8 4122.6 4151.6 4187.4 1331.4 1354.3 1364.3 1372.4 1374.6 845.3 858.6 869.8 888.7 948.4 5882.9 5932.2 5985.7 6109.6 6191.3 819.0 951.4 957.4 972.3 995.8 3868.5 4000.2 4015.9 4041.7 4049.4 10224.9 10703.6 10725.8 10747.1 10829.8 9794.2 10128.6 10636.5 10655.2 10924.8 6998.3 7089.5 8148.3 8168.1 8182.7 4894.7 5928.2 5959.5 6040.4 6065.3 9478.3 9602.4 9702.9 9719.3 9739.4 8106.6 8947.2 9563.8 9831.9 10087.7 6939.3 7309.0 7499.7 7548.7 7571.0 8245.3 8257.9 8294.8 8298.4 8305.6 7211.1 7328.0 7362.8 7455.0 7511.0 6372.6 7185.0 7322.6 7333.3 7348.6 6983.2 7024.3 7068.8 7081.1 7081.2 4872.6 4945.0 4963.4 5034.2 5161.8 4782.9 4943.0 5010.2 5163.5 5242.2 21:46:56 INFO - PROCESS | 1664 | 21:46:56 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5145.61 Median:5801.35 stddev:1662.46 (28.7%) stddev-sans-first:1627.04 21:46:56 INFO - PROCESS | 1664 | Values: 311.2 318.8 320.3 328.3 329.7 4622.0 5102.7 5172.6 5832.2 5962.8 4651.8 5182.2 6030.6 6065.3 6066.8 4254.6 4448.5 4496.0 4501.2 4519.4 3823.9 4168.6 4454.4 4456.6 4487.4 3902.6 4129.6 4410.1 4419.8 4424.0 4194.3 4390.7 4426.2 4442.9 4445.5 3399.0 3666.5 3788.8 3792.8 3823.2 5066.5 5069.5 5726.5 5743.6 5753.8 4916.4 5095.2 5119.5 5129.9 5136.1 5251.9 5746.7 6202.8 6337.2 6383.2 3537.3 3572.4 4207.0 4214.8 4233.3 5613.5 5770.5 6459.5 6665.8 6734.2 3743.4 4157.8 4251.3 4266.1 4288.2 4325.3 4334.2 4353.0 4356.4 4365.3 4452.0 5107.9 5120.0 5145.2 5149.6 5703.3 5850.5 6219.5 6406.6 6408.7 1241.6 1344.8 1417.0 1503.5 1510.7 875.5 889.5 977.0 984.6 995.6 5548.3 5906.5 5967.0 5990.4 6012.8 5843.7 6082.4 6644.6 6645.9 6697.8 5416.3 5950.9 6095.3 6098.7 6137.3 3433.8 3508.3 3550.7 3567.2 3569.4 6195.9 6524.3 6979.3 6979.7 7021.9 5554.4 6909.3 6915.0 6936.8 6943.4 6643.3 6846.9 7023.3 7029.8 7055.0 6711.5 6720.8 6721.4 6745.6 6750.7 6452.7 6577.0 6613.9 6639.4 6641.9 6938.2 6962.0 6990.4 7000.4 7001.8 3669.6 4268.7 4313.6 4314.4 4330.4 5507.1 6340.4 6485.9 6498.5 6664.5 6462.6 6476.6 6490.2 6498.7 6501.6 6211.0 6432.1 6449.1 6457.0 6460.7 5050.3 6103.0 6263.6 6299.1 6338.3 5554.0 6306.6 6477.7 6481.8 6499.4 6054.5 6276.4 6326.5 6328.6 6328.9 21:46:56 INFO - PROCESS | 1664 | 21:46:56 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:17276.68 Median:3165.42 stddev:23391.73 (739.0%) stddev-sans-first:23424.35 21:46:56 INFO - PROCESS | 1664 | Values: 727.2 740.8 744.5 763.2 778.1 14851.9 14966.1 15177.2 15486.0 15545.3 11845.8 13796.3 13797.7 14100.9 14265.7 711.2 883.7 890.1 898.3 901.6 900.4 913.6 917.6 918.4 923.0 947.5 955.5 957.3 968.2 973.8 933.0 954.9 960.3 970.3 973.5 695.6 696.0 701.8 705.2 721.6 14876.2 15065.6 15122.5 15159.6 15204.2 12850.2 12932.5 13035.9 13065.5 13203.9 10101.8 10108.8 10199.5 10293.1 10594.9 3286.8 3501.5 3559.9 3572.0 3610.2 81765.0 81975.0 84456.6 85250.6 85319.6 7716.6 9512.6 9539.3 9672.9 9764.8 22657.0 22832.3 22848.4 22869.9 22890.0 5757.9 7518.1 7523.7 7537.4 7560.0 3911.5 4030.8 4040.5 4048.5 4058.1 3115.8 3645.7 3657.1 3669.7 3708.9 572.9 649.5 653.6 658.0 662.8 501.1 530.4 554.3 565.3 592.4 7920.1 7963.1 8030.2 8081.7 8088.4 439.6 500.8 582.1 595.5 621.6 3643.7 4082.5 4128.3 4204.6 4275.7 73157.0 74225.0 79381.8 79417.0 79908.6 57009.0 57638.7 60220.1 63432.0 74841.0 69466.0 70818.6 71187.6 71221.6 71620.3 8165.6 8271.2 8345.8 8405.1 8463.0 42394.0 42455.6 43214.6 43751.6 44966.6 57983.4 62139.7 62643.0 63011.0 63909.7 10877.6 10926.9 10935.8 11188.0 11310.9 11899.0 12034.6 12056.8 12137.3 12489.0 11229.0 11428.1 11760.0 11874.5 11949.5 11565.7 11733.7 11818.9 11962.3 11985.6 11282.8 11301.4 11333.6 11521.0 11878.5 9650.7 9809.3 10018.2 10030.6 10239.1 7833.0 9748.0 9779.7 9782.9 9909.8 21:46:56 INFO - PROCESS | 1664 | -------- Summary: end -------- 21:46:56 INFO - PROCESS | 1664 | 21:46:56 INFO - TEST-INFO | 1664: exit 0 21:46:57 INFO - TEST-OK | dromaeo_css | took 1111648ms 21:46:57 INFO - TEST-START | kraken 21:46:57 INFO - operating with platform_type : mac_ 21:46:57 INFO - Initialising browser for kraken test... 21:46:57 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmptkqqxS/profile http://localhost:49279/getInfo.html) 21:46:59 INFO - PROCESS | 1677 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 21:46:59 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 21:46:59 INFO - PROCESS | 1677 | colorDepth:24 21:46:59 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 21:46:59 INFO - PROCESS | 1677 | __metrics 21:46:59 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 21:47:00 INFO - TEST-INFO | 1677: exit 0 21:47:00 INFO - Browser initialized. 21:47:00 INFO - Running cycle 1/1 for kraken test... 21:47:00 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmptkqqxS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:12 INFO - PROCESS | 1680 | RSS: Main: 248180736 21:47:12 INFO - PROCESS | 1680 | 21:47:15 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 21:47:16 INFO - PROCESS | 1680 | RSS: Main: 260472832 21:47:16 INFO - PROCESS | 1680 | 21:47:18 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 21:47:19 INFO - PROCESS | 1680 | RSS: Main: 269398016 21:47:19 INFO - PROCESS | 1680 | 21:47:22 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 21:47:23 INFO - PROCESS | 1680 | RSS: Main: 272289792 21:47:23 INFO - PROCESS | 1680 | 21:47:25 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 21:47:26 INFO - PROCESS | 1680 | RSS: Main: 274280448 21:47:26 INFO - PROCESS | 1680 | 21:47:28 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:47:28 INFO - PROCESS | 1680 | RSS: Main: 274821120 21:47:28 INFO - PROCESS | 1680 | 21:47:31 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 21:47:32 INFO - PROCESS | 1680 | RSS: Main: 275070976 21:47:32 INFO - PROCESS | 1680 | 21:47:35 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 21:47:36 INFO - PROCESS | 1680 | RSS: Main: 275120128 21:47:36 INFO - PROCESS | 1680 | 21:47:39 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 21:47:39 INFO - PROCESS | 1680 | RSS: Main: 275341312 21:47:39 INFO - PROCESS | 1680 | 21:47:41 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:47:42 INFO - PROCESS | 1680 | RSS: Main: 275099648 21:47:42 INFO - PROCESS | 1680 | 21:47:44 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:47:44 INFO - PROCESS | 1680 | RSS: Main: 275247104 21:47:44 INFO - PROCESS | 1680 | 21:47:47 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:47:47 INFO - PROCESS | 1680 | RSS: Main: 275341312 21:47:47 INFO - PROCESS | 1680 | 21:47:50 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:47:51 INFO - PROCESS | 1680 | RSS: Main: 275308544 21:47:51 INFO - PROCESS | 1680 | 21:47:54 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:47:54 INFO - PROCESS | 1680 | RSS: Main: 275529728 21:47:54 INFO - PROCESS | 1680 | 21:47:56 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 21:47:57 INFO - PROCESS | 1680 | RSS: Main: 276987904 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | __start_tp_report 21:47:57 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 21:47:57 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 21:47:57 INFO - PROCESS | 1680 | |i|pagename|runs| 21:47:57 INFO - PROCESS | 1680 | |0;ai-astar;115;109;115;118;114;129;114;116;116;116 21:47:57 INFO - PROCESS | 1680 | |1;audio-beat-detection;180;126;137;162;121;141;137;193;151;120 21:47:57 INFO - PROCESS | 1680 | |2;audio-dft;197;196;201;234;263;213;202;196;199;196 21:47:57 INFO - PROCESS | 1680 | |3;audio-fft;64;71;106;132;83;81;81;123;115;77 21:47:57 INFO - PROCESS | 1680 | |4;audio-oscillator;84;85;130;78;81;89;122;82;79;120 21:47:57 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;117;129;93;85;88;87;90;86;89;86 21:47:57 INFO - PROCESS | 1680 | |6;imaging-darkroom;116;152;106;152;148;112;96;109;102;88 21:47:57 INFO - PROCESS | 1680 | |7;imaging-desaturate;109;92;97;116;99;105;148;134;134;133 21:47:57 INFO - PROCESS | 1680 | |8;json-parse-financial;58;62;61;60;81;82;85;96;90;74 21:47:57 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;66;70;68;70;76;85;102;99;100;101 21:47:57 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;91;86;110;114;114;74;103;112;74;101 21:47:57 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;148;144;142;144;136;151;155;141;188;169 21:47:57 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;169;169;171;171;173;168;170;170;178;173 21:47:57 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;69;71;60;66;97;95;96;99;92;89 21:47:57 INFO - PROCESS | 1680 | __end_tp_report 21:47:57 INFO - PROCESS | 1680 | __start_cc_report 21:47:57 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,979 21:47:57 INFO - PROCESS | 1680 | __end_cc_report 21:47:57 INFO - PROCESS | 1680 | __startTimestamp1460609277020__endTimestamp 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | ------- Summary: start ------- 21:47:57 INFO - PROCESS | 1680 | Number of tests: 14 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:116.20 Median:116.00 stddev:5.07 (4.4%) stddev-sans-first:5.36 21:47:57 INFO - PROCESS | 1680 | Values: 115.0 109.0 115.0 118.0 114.0 129.0 114.0 116.0 116.0 116.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:146.00 stddev:24.78 (17.0%) stddev-sans-first:23.19 21:47:57 INFO - PROCESS | 1680 | Values: 180.0 126.0 137.0 162.0 121.0 141.0 137.0 193.0 151.0 120.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:209.70 Median:201.50 stddev:22.15 (11.0%) stddev-sans-first:23.01 21:47:57 INFO - PROCESS | 1680 | Values: 197.0 196.0 201.0 234.0 263.0 213.0 202.0 196.0 199.0 196.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:93.30 Median:74.00 stddev:23.67 (32.0%) stddev-sans-first:22.61 21:47:57 INFO - PROCESS | 1680 | Values: 64.0 71.0 106.0 132.0 83.0 81.0 81.0 123.0 115.0 77.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:81.50 stddev:20.40 (25.0%) stddev-sans-first:21.25 21:47:57 INFO - PROCESS | 1680 | Values: 84.0 85.0 130.0 78.0 81.0 89.0 122.0 82.0 79.0 120.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:87.50 stddev:15.20 (17.4%) stddev-sans-first:13.88 21:47:57 INFO - PROCESS | 1680 | Values: 117.0 129.0 93.0 85.0 88.0 87.0 90.0 86.0 89.0 86.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:118.10 Median:150.00 stddev:23.84 (15.9%) stddev-sans-first:25.28 21:47:57 INFO - PROCESS | 1680 | Values: 116.0 152.0 106.0 152.0 148.0 112.0 96.0 109.0 102.0 88.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:116.70 Median:141.00 stddev:19.30 (13.7%) stddev-sans-first:20.27 21:47:57 INFO - PROCESS | 1680 | Values: 109.0 92.0 97.0 116.0 99.0 105.0 148.0 134.0 134.0 133.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:74.90 Median:81.50 stddev:13.87 (17.0%) stddev-sans-first:13.29 21:47:57 INFO - PROCESS | 1680 | Values: 58.0 62.0 61.0 60.0 81.0 82.0 85.0 96.0 90.0 74.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:83.70 Median:70.00 stddev:15.38 (22.0%) stddev-sans-first:14.92 21:47:57 INFO - PROCESS | 1680 | Values: 66.0 70.0 68.0 70.0 76.0 85.0 102.0 99.0 100.0 101.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:97.90 Median:94.00 stddev:15.74 (16.7%) stddev-sans-first:16.50 21:47:57 INFO - PROCESS | 1680 | Values: 91.0 86.0 110.0 114.0 114.0 74.0 103.0 112.0 74.0 101.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:149.50 stddev:15.69 (10.5%) stddev-sans-first:16.58 21:47:57 INFO - PROCESS | 1680 | Values: 148.0 144.0 142.0 144.0 136.0 151.0 155.0 141.0 188.0 169.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:171.00 stddev:2.90 (1.7%) stddev-sans-first:2.96 21:47:57 INFO - PROCESS | 1680 | Values: 169.0 169.0 171.0 171.0 173.0 168.0 170.0 170.0 178.0 173.0 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.40 Median:93.50 stddev:15.05 (16.1%) stddev-sans-first:15.03 21:47:57 INFO - PROCESS | 1680 | Values: 69.0 71.0 60.0 66.0 97.0 95.0 96.0 99.0 92.0 89.0 21:47:57 INFO - PROCESS | 1680 | -------- Summary: end -------- 21:47:57 INFO - PROCESS | 1680 | 21:47:57 INFO - TEST-INFO | 1680: exit 0 21:47:57 INFO - TEST-OK | kraken | took 60920ms 21:47:57 INFO - SUITE-END | took 1172s 21:47:58 INFO - Completed test suite (00:19:32) 21:47:58 INFO - javascript benchmark 21:47:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3479.495473156393, 3492.563429571303, 3517.0, 3522.9471557926618, 3556.5554305711785, 5860.384659610738, 5906.822795316137, 5928.644281343117, 5945.791897283596, 5952.851178720529, 5785.884282314351, 5910.379410161936, 5914.822555323336, 5990.131430942511, 6060.606060606068, 5170.508801663846, 5272.31459910213, 5290.2064690296575, 5303.257543943851, 5344.7862085516535, 340.05059739588523, 4108.4453598764085, 5267.28891599633, 5294.2058691196435, 5344.5724342052545, 5193.792248310063, 5251.369835619712, 5257.684538927658, 5261.579073674096, 5288.103764302813, 4530.478994915594, 5121.4110377306715, 5360.195970604402, 5365.892682146375, 5388.353397592275, 4301.225779359714, 5163.7159956202395, 5188.662736922088, 5250.894982100374, 5281.313429254173, 5602.831915042555, 5694.914576281359, 5744.626599271034, 5771.0, 5810.099434587646, 6145.095020543601, 6178.876422471525, 6255.655938923357, 6281.120643109968, 6304.022876454157, 6227.719752611143, 6246.969250073777, 6279.026750853625, 6297.811065668037, 6310.5267104967315, 5957.970210148965, 5969.880602387928, 5985.910211346833, 6012.699365031731, 6075.058365953284, 5423.566114710814, 6223.439890409885, 6314.926462501386, 6353.205849268841, 6357.300696923335, 6212.81361559154, 6218.098375735493, 6224.533160013018, 6253.874922501615, 6286.308506064329, 6224.688765561704, 6234.407731265614, 6263.78076767311, 6270.153529273581, 6284.465820405317, 6145.508359331243, 6181.660008699475, 6219.346968568326, 6254.781082662176, 6285.748570057238, 6108.6029408089225, 6197.411245931629, 6260.342664020212, 6276.089966954766, 6280.371962803683, 4225.345071513921, 4954.900901982012, 5011.6241281904, 5014.924776128361, 5025.14572522672, 4377.146456440963, 4450.532694067141, 4497.168023915586, 4514.0, 4542.772861356919, 5980.252468441445, 6019.54853385989, 6027.156198132265, 6056.0, 6057.303410107894, 6309.810705678837, 6315.210598675166, 6325.3674632537295, 6328.778492752732, 6330.905036424458, 5865.824025279248, 5949.530944658005, 5983.1623572699855, 6076.0885867119405, 6083.8174854754425, 5498.532624726863, 5498.5876059295715, 5501.339839219239, 5507.339119305709, 5508.697021663847, 6487.18910136233, 6493.480521558264, 6494.350564943562, 6497.382748638872, 6505.121808555879, 6173.536984726254, 6224.844378890564, 6254.562180647311, 6290.685465726787, 6312.747490100344, 6419.646919419477, 6424.935750642434, 6466.644334561456, 6476.0, 6484.319146489551, 6119.715820550657, 6208.2239720034995, 6234.688265586793, 6239.719212635351, 6267.2165979252595, 4966.106100901728, 5052.216906379517, 5997.430244126801, 6259.530535209787, 6262.499000079892, 6242.719077641426, 6257.624542527463, 6258.624482531062, 6280.0893870389455, 6284.528660350584, 5115.462876398074, 6028.788992385421, 6213.37866213375, 6253.405926436982, 6282.246130464374, 4526.796294166705, 4961.2806143109765, 5393.919091213556, 6109.11417844419, 6113.29697084841, 5262.473752624707, 5986.580939334205, 6124.081387791867, 6200.131981522681, 6218.06728990655, 5385.434529374516, 5977.402259773988, 6083.482903953213, 6132.41742034506, 6136.417040381157], "value": 5687.792390829991, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.8717739798953, 529.6504307157275, 547.6495043172371, 548.6570893191754, 592.1946153231602, 36484.63515364846, 37210.44184337237, 37227.0, 37245.813770931105, 37278.813605931966, 39474.0, 40034.79982600083, 40378.79810600943, 40426.39360409596, 40563.797181014124, 7709.922900770991, 9549.570269337863, 9551.99704031077, 9583.424994500352, 9635.13283804461, 9525.047495250488, 9574.90425095747, 9595.0, 9643.517824108802, 9667.903320966805, 9555.092266234697, 9581.520923953809, 9622.278329125309, 9628.759281017996, 9667.0, 9571.760705982337, 9572.282078844044, 9583.856242156373, 9632.47021413822, 9653.986331435239, 8397.992240931128, 9465.195458385977, 9467.66863159786, 9484.19384352331, 9537.570809313598, 36670.449943250875, 37097.81451092754, 37206.0, 37299.0, 37460.625393745984, 2768.224897028815, 3030.681778413257, 3135.937281254362, 3362.1258472797003, 3388.881389151368, 25475.61786573203, 25669.871650641628, 25737.0, 26350.86824565884, 26935.32661683454, 2645.6031595260865, 2679.9866000670067, 2720.7551320381062, 2722.992492777665, 2774.9861250693616, 247174.0, 302003.0, 303750.0, 314440.0, 316514.0, 32281.51577726336, 32509.024729257686, 32653.183670407954, 32663.183420414203, 32680.509792353132, 51715.48284517182, 65594.67202664052, 65700.0, 66211.0, 66347.66826165839, 16003.519894403187, 16024.75962860558, 16228.756568651479, 16295.022298661881, 16615.916920415322, 12342.197757145757, 12491.125621206611, 12573.748525029449, 12599.118061735591, 12757.55348562796, 19051.237950482104, 19175.0, 19190.0, 19201.903990479957, 19483.8051619482, 8142.0, 8259.587020648944, 8286.337093032664, 8301.916980830236, 8326.916730832736, 842.6671464771381, 923.5013092929877, 1075.510642657589, 1075.58589942871, 1085.159001773616, 22949.0, 29244.85377573141, 29673.387735699725, 29845.95539156119, 29860.55209171864, 1050.2753100360878, 1088.374184843718, 1115.0800589513683, 1170.3621526268205, 1193.785118678646, 14593.92703036478, 14664.0, 14928.0, 15287.617809554627, 15365.231738413035, 618901.0, 635321.0, 635644.0, 638412.0, 639016.0, 57325.0, 58348.0, 58923.0, 58961.70519147377, 59184.70407647934, 1404.7471455138173, 1416.5113036002563, 1439.0933711761522, 1467.1270593996555, 1469.1332114052973, 25049.499010020063, 29194.270143246587, 29515.704842951294, 29738.553921691626, 29831.0, 49541.25688114609, 49674.75162624164, 50293.0, 50510.74744626253, 50675.0, 564191.0, 567714.0, 569259.0, 570200.0, 570402.0, 25765.871170644026, 31544.211394715316, 42014.0, 42062.57937420587, 42157.57842421659, 42997.785011074746, 43646.12707745891, 43788.0, 43953.0, 44526.3321050191, 35814.4627830588, 36016.0, 36052.45921311235, 36788.63211367959, 36953.0, 31874.0, 35890.820545897106, 36090.63909360873, 36916.44625330569, 37035.62964370322, 35354.29291414106, 35497.645023549434, 35680.7511737088, 35924.101897452776, 36068.63931360653, 26973.46053078888, 31471.47027666811, 31820.68179318177, 31829.840850795597, 31884.202894927814, 21038.68441973402, 22901.77098229063, 23691.881540592185, 24158.154464593656, 24581.385465362793], "value": 19005.378241501436, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.78728719975607, 352.4167502782894, 352.46425433341307, 384.7479900665064, 392.78789453695026, 20297.0, 20510.179592816286, 20921.0, 21670.458238544063, 21867.343979680594, 17291.913540432313, 20664.276750313744, 21064.789352106476, 21294.041768120434, 21563.892180539115, 4635.327877457767, 5736.541076713864, 5891.617044892089, 5986.132010858423, 6589.406953374195, 6413.807585772434, 6435.034744788272, 6482.319356467574, 6496.57772244805, 6498.415142637162, 6005.819825405245, 6406.807795766134, 6414.422701956823, 6417.6149431034055, 6430.099786029959, 5480.6437581557075, 5701.572382071361, 5902.704864756788, 6290.182276304097, 6368.777092801753, 5204.141316682781, 5455.972720136414, 5642.548596112301, 5663.66018038919, 5777.5666824987875, 11582.942085289604, 13237.86762132376, 13475.663108422368, 13539.39072741729, 14831.48089816862, 2013.0, 2041.469218003315, 2069.3584988653565, 2098.234144537248, 2127.1172463427815, 9724.270679699051, 9839.852402213972, 9874.654387096418, 9907.702768916944, 10185.185185185168, 1679.4541773923402, 1780.64387122576, 1810.185416562552, 1823.3618233618126, 1843.4377514857963, 118002.0, 122395.38802306021, 122819.54360912822, 125307.3734631321, 126698.0, 11711.648650540497, 11715.25585987151, 11726.589569365031, 11731.120165987584, 11829.940850295865, 14996.325165367585, 15007.324670389859, 15020.624484387978, 15058.924705376403, 15111.244437778067, 8613.69852055175, 8645.178708022853, 8696.78258043554, 8737.825243495094, 8807.91192088071, 8308.086110527836, 8524.95737521321, 8527.74416767498, 8552.486850788848, 8653.0, 4554.544545545486, 4559.247724125482, 4637.1421287062, 4654.868490504025, 4712.64655150865, 1941.708743688458, 2007.427883053352, 2009.0657844102564, 2009.1360714892737, 2020.2928974858683, 902.264654306738, 950.9572069256761, 954.8090381923643, 1007.8034783217349, 1047.638564695179, 20443.897780511, 20752.0, 20818.79181208199, 21027.68458473124, 21056.0, 954.613381580461, 955.507913424587, 976.097110173087, 979.1432496565506, 1031.376017509411, 10749.892501075046, 11033.951774581403, 11044.0, 11079.889201108046, 11098.889011109786, 580525.0, 599578.0, 600273.0, 613519.0, 617476.0, 130084.0, 131123.0, 133088.0, 134835.32582337025, 135441.3227933854, 1000.849872519128, 1026.8151732688189, 1033.0599154769275, 1050.0706874416044, 1054.920880933933, 14296.356663950355, 16777.32890684408, 17673.64652706913, 18168.182431790865, 18598.884066956027, 35364.0, 48659.51340486691, 49682.75158624184, 50802.74598626983, 51119.0, 69425.0, 75071.49857002939, 76161.0, 76686.61656691681, 76995.61502192453, 7434.7769566913075, 7747.18654541265, 7948.8807667886185, 7959.801004974922, 8176.264136227768, 10128.594856205964, 11485.942570287096, 12359.814602781145, 12673.239605623692, 12834.037447191684, 10228.31232846572, 10352.17182625373, 10744.677659670222, 10840.45797710127, 11345.149113816331, 10652.89347106519, 10680.89319106799, 11051.557937682725, 11164.888351116384, 11265.493052812806, 10723.517441714985, 10868.565257389615, 10915.345079295268, 10941.56233750641, 11118.777624447304, 6872.62200578973, 7945.20547945224, 8027.438079334391, 8063.83872322562, 8338.833223335378, 8213.630386632496, 9041.0, 10386.37681739068, 11184.608538701106, 11256.887431125911], "value": 9355.172577807767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.9478820847166, 1510.131674287285, 1586.7699183618367, 1736.8263173682633, 1835.559465728224, 7467.9918211041495, 8084.070331911832, 8687.652493900236, 8799.868001979967, 8903.91096089039, 8618.95690521548, 8623.310135189186, 8659.047504774486, 8696.608652610632, 8783.429077109984, 2419.3104965084954, 2441.914532991346, 2444.6699695541142, 2452.3010941881566, 2452.9386765330833, 2132.8400369972314, 2284.132029828663, 2417.4319035026756, 2428.089466450081, 2469.1604854349516, 2240.820734341257, 2448.608222684371, 2471.938201544958, 2483.7640424159677, 2484.043643197373, 2436.0377650827822, 2454.1287842815723, 2459.963100553493, 2459.9754002459927, 2476.727559968402, 2433.221369161869, 2433.3551608823677, 2443.438009257863, 2462.5198086373166, 2466.6300054991893, 8829.117088291183, 8867.955660221722, 8881.978572464184, 8978.191962723386, 8991.730248092568, 5271.262023316739, 5362.302900622933, 5398.541124004464, 5491.28613280275, 5521.337439507285, 3615.584207816082, 3639.581448133472, 3642.435422509489, 3647.8723244686307, 3661.5972243053243, 1035.0580971316142, 1055.5091882274703, 1056.1023130339227, 1074.462768615692, 1096.1723898456694, 11457.0, 11494.0, 11549.076073914066, 11558.884411155865, 11566.90114439127, 4794.712317260975, 4849.636277279218, 4880.389951256093, 4925.13810083234, 5002.674826136289, 9884.357516761387, 9944.30389872702, 9961.501924903725, 9981.700548983543, 9982.650607228712, 5352.759125839347, 5387.299651045418, 5413.918791218135, 5456.454354564512, 5464.535514481234, 4448.688591798607, 4828.565429111397, 4949.90100197994, 4965.751712414437, 4988.90022199554, 4077.2049450356894, 4093.752474463508, 4122.56713045132, 4151.584841515824, 4187.413762073312, 1331.391927875449, 1354.2754626274896, 1364.3382959264748, 1372.4235820955223, 1374.6425929258464, 845.2857335551572, 858.5921687198655, 869.8341130584798, 888.7422647432302, 948.3740731117567, 5882.882342353129, 5932.228810254639, 5985.730642121115, 6109.602875813058, 6191.288001879751, 818.9672413103528, 951.3863558005187, 957.4303289542711, 972.2805124208035, 995.8456439251928, 3868.516435445569, 4000.179963107556, 4015.859444919414, 4041.7372870763306, 4049.3521036633997, 10224.897751022394, 10703.571857125628, 10725.78548429027, 10747.086497647788, 10829.783404331869, 9794.167495762798, 10128.59485620567, 10636.46817659114, 10655.200859935381, 10924.781504370027, 6998.335158159966, 7089.468289878177, 8148.26665600087, 8168.060673022678, 8182.672693092329, 4894.681845680019, 5928.170056192051, 5959.523238141025, 6040.426159515015, 6065.272167339947, 9478.336516443782, 9602.375845570015, 9702.9029709702, 9719.271054670786, 9739.41563506192, 8106.635201416068, 8947.19475247231, 9563.808723825345, 9831.85252221203, 10087.69736907894, 6939.30606939302, 7309.013283206699, 7499.662515186938, 7548.698052078075, 7571.0, 8245.257926786619, 8257.917420825715, 8294.792630184294, 8298.377621678519, 8305.584720764058, 7211.134663840163, 7328.047353843966, 7362.779116626296, 7454.993575867188, 7510.962445187739, 6372.617642941438, 7185.0, 7322.560646361236, 7333.266673332624, 7348.632568371667, 6983.1620205575655, 7024.26245244242, 7068.823279418056, 7081.114860642419, 7081.150261968597, 4872.634552408513, 4944.950550494449, 4963.429205641398, 5034.16936205522, 5161.793528258978, 4782.856514304437, 4942.950570494249, 5010.223415370623, 5163.535281824654, 5242.16125419931], "value": 4604.870896508412, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.20487155318165, 318.7816345803125, 320.2937522762309, 328.3252915259142, 329.6752698591888, 4621.953780462203, 5102.744862756866, 5172.560332371748, 5832.1834943108, 5962.807438512298, 4651.837185698501, 5182.2016111299945, 6030.608010479315, 6065.332813390523, 6066.757329706807, 4254.574717469636, 4448.510663826976, 4496.0, 4501.189785838547, 4519.4124763780665, 3823.9044023899346, 4168.5623009584015, 4454.37638730578, 4456.5766252205985, 4487.3717679524725, 3902.6487616114546, 4129.6283334499885, 4410.140022695576, 4419.845305414311, 4423.977880110611, 4194.266003449415, 4390.714603550759, 4426.22541055314, 4442.911141777146, 4445.51099379068, 3398.9633161885613, 3666.4866918631415, 3788.7916164610933, 3792.829322680486, 3823.1780167264174, 5066.493350664941, 5069.493050694938, 5726.484616384504, 5743.59794814359, 5753.769849206027, 4916.385451818523, 5095.184770436749, 5119.462456442057, 5129.871753206163, 5136.101182293121, 5251.92335571207, 5746.683932383718, 6202.751889924398, 6337.176167098294, 6383.170187875593, 3537.284417057725, 3572.392693242129, 4207.0, 4214.7681877496725, 4233.343831706091, 5613.494785469327, 5770.509506691937, 6459.479583626935, 6665.800025999228, 6734.158230221223, 3743.435746513647, 4157.835805974332, 4251.320728312299, 4266.1254442839145, 4288.185244803477, 4325.329573916048, 4334.1981733379425, 4353.0423306872435, 4356.433663623772, 4365.323374876899, 4452.0, 5107.901801112778, 5119.950410165981, 5145.228215767665, 5149.639525233272, 5703.287089113861, 5850.473457388855, 6219.502439804804, 6406.583572067801, 6408.743650253938, 1241.5778635263873, 1344.7781116115927, 1417.0080943339703, 1503.518873960344, 1510.6903084867795, 875.5140896802336, 889.5418859287472, 977.0327375897951, 984.5618699678718, 995.6216637677636, 5548.306461692288, 5906.468417842415, 5966.970165149147, 5990.371011043778, 6012.849678757979, 5843.737031833492, 6082.422169893853, 6644.568103073285, 6645.900311495331, 6697.799066028027, 5416.2688037114485, 5950.940490595125, 6095.329513753483, 6098.6762214593155, 6137.324894261627, 3433.7939723616664, 3508.2808024354945, 3550.6981906537717, 3567.2152126532123, 3569.3575156472084, 6195.938040619626, 6524.282328943812, 6979.267176946449, 6979.6859141337745, 7021.89467157993, 5554.444555544494, 6909.30906909305, 6914.965425172943, 6936.79189624312, 6943.409810166091, 6643.335666433318, 6846.897296540656, 7023.33278338557, 7029.824254393681, 7055.0, 6711.4966377520905, 6720.8319792005595, 6721.395074443323, 6745.628990405575, 6750.729970801113, 6452.709628066655, 6576.967115164393, 6613.933860661525, 6639.402453779183, 6641.867162656623, 6938.167419909643, 6961.965190174219, 6990.370866622028, 7000.369966703021, 7001.844695625368, 3669.6146904575703, 4268.679849011399, 4313.61177494027, 4314.439122914001, 4330.372096046119, 5507.108767896886, 6340.365963403808, 6485.929821579387, 6498.545101842826, 6664.500487390298, 6462.612243265231, 6476.643784591704, 6490.221173459215, 6498.707558159988, 6501.577397469149, 6210.968945155245, 6432.13166222554, 6449.097126402401, 6457.0, 6460.709268082854, 5050.292958985819, 6102.969485152724, 6263.592866463848, 6299.086632438362, 6338.271098823694, 5554.0, 6306.558540902093, 6477.708503117466, 6481.805545833632, 6499.350064993463, 6054.48536874353, 6276.435120839146, 6326.493880489642, 6328.588641738273, 6328.936710633019], "value": 4602.296220040374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.2218725963219, 740.8296091898864, 744.5086243079569, 763.1681467200751, 778.0546635837457, 14851.851481485182, 14966.102033877974, 15177.241137943114, 15485.993410428327, 15545.300461479246, 11845.822312665317, 13796.310184490785, 13797.724045519084, 14100.858991410083, 14265.71468570628, 711.2283172757565, 883.6553744039829, 890.1410139215656, 898.2723993565234, 901.5717534171282, 900.3832374823266, 913.6162811619103, 917.6146018672174, 918.3571499950028, 922.9769255768626, 947.5072962059725, 955.5126885288519, 957.3346524165707, 968.2254196642658, 973.8149751547219, 933.0, 954.8710924025272, 960.3133759362055, 970.2965350121176, 973.5473005052613, 695.6452209373256, 695.9826004349881, 701.8385771272585, 705.1573369823063, 721.5598484924192, 14876.181810000446, 15065.623359416102, 15122.54632361031, 15159.62100947474, 15204.239788010555, 12850.164739291917, 12932.48270069196, 13035.86964130356, 13065.542706005244, 13203.86796132036, 10101.797964040752, 10108.797824043551, 10199.490025498695, 10293.073623373932, 10594.947025264824, 3286.802791832498, 3501.4922836188866, 3559.857605695795, 3571.982140089283, 3610.2238018825815, 81765.0, 81975.0, 84456.57771711164, 85250.57374713087, 85319.57340213259, 7716.614169291513, 9512.619495220113, 9539.284553658503, 9672.903270967341, 9764.755881103029, 22657.0, 22832.31503054911, 22848.428789280402, 22869.88565057164, 22889.96995135223, 5757.942420575824, 7518.097828260535, 7523.661435235427, 7537.434692398092, 7559.962200188964, 3911.491506104245, 4030.778307193074, 4040.454538637305, 4048.4534587830854, 4058.1477889642915, 3115.813051216934, 3645.7265705072227, 3657.104009517685, 3669.669729724284, 3708.925821483609, 572.9054705973467, 649.4577028181427, 653.5523166630778, 657.980260592183, 662.7912207654573, 501.12053346377604, 530.4032962916718, 554.2932760730021, 565.2849145830528, 592.380961894821, 7920.089189743138, 7963.098081939807, 8030.19698030204, 8081.676732930735, 8088.433809633269, 439.5999640327287, 500.78215976050535, 582.0657844160147, 595.4521839907296, 621.6487684458267, 3643.6720695137565, 4082.4896887889013, 4128.318827393447, 4204.62158405745, 4275.700700950903, 73157.0, 74225.0, 79381.80927286095, 79417.0, 79908.60045699851, 57009.0, 57638.7118064407, 60220.096698549554, 63432.04851927225, 74841.0, 69466.0, 70818.64590677117, 71187.64406177936, 71221.64389178022, 71620.28379716241, 8165.632546535539, 8271.2142346477, 8345.833083338177, 8405.075441701285, 8463.026751923362, 42394.0, 42455.575444246395, 43214.56785432105, 43751.56248437602, 44966.550334496234, 57983.420165797805, 62139.689301553204, 62643.0, 63011.0, 63909.68045159744, 10877.564897404016, 10926.945365273123, 10935.781284374109, 11188.0, 11310.92546208109, 11899.048076153715, 12034.63896083119, 12056.819147712968, 12137.332446715161, 12489.0, 11229.0, 11428.142889283503, 11760.0, 11874.52501899949, 11949.462274197856, 11565.7108572283, 11733.706657333634, 11818.940905295418, 11962.282263064244, 11985.580504682293, 11282.774344513227, 11301.434928253719, 11333.613126286324, 11521.0, 11878.524859005543, 9650.71047868565, 9809.313348065853, 10018.248631352824, 10030.64892728751, 10239.078482936273, 7833.0, 9748.0, 9779.706608801747, 9782.9021709782, 9909.752256193364], "value": 6806.504938982453, "unit": "score"}], "name": "dromaeo_css", "value": 7255.564403617293, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 115.0, 118.0, 114.0, 129.0, 114.0, 116.0, 116.0, 116.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 126.0, 137.0, 162.0, 121.0, 141.0, 137.0, 193.0, 151.0, 120.0], "value": 146.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 196.0, 201.0, 234.0, 263.0, 213.0, 202.0, 196.0, 199.0, 196.0], "value": 209.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 106.0, 132.0, 83.0, 81.0, 81.0, 123.0, 115.0, 77.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 130.0, 78.0, 81.0, 89.0, 122.0, 82.0, 79.0, 120.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 129.0, 93.0, 85.0, 88.0, 87.0, 90.0, 86.0, 89.0, 86.0], "value": 95.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 152.0, 106.0, 152.0, 148.0, 112.0, 96.0, 109.0, 102.0, 88.0], "value": 118.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 92.0, 97.0, 116.0, 99.0, 105.0, 148.0, 134.0, 134.0, 133.0], "value": 116.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 61.0, 60.0, 81.0, 82.0, 85.0, 96.0, 90.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 68.0, 70.0, 76.0, 85.0, 102.0, 99.0, 100.0, 101.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 110.0, 114.0, 114.0, 74.0, 103.0, 112.0, 74.0, 101.0], "value": 97.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 144.0, 142.0, 144.0, 136.0, 151.0, 155.0, 141.0, 188.0, 169.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 171.0, 171.0, 173.0, 168.0, 170.0, 170.0, 178.0, 173.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 60.0, 66.0, 97.0, 95.0, 96.0, 99.0, 92.0, 89.0], "value": 83.4, "unit": "score"}], "name": "kraken", "value": 1653.7000000000003, "alertThreshold": 2.0}]} 21:47:58 INFO - Return code: 0 21:47:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:47:58 ERROR - # TBPL SUCCESS # 21:47:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:47:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:47:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:47:58 INFO - 2016-04-13 21:47:58.337 screenresolution[1685:10303] starting screenresolution argv=screenresolution get 21:47:58 INFO - 2016-04-13 21:47:58.340 screenresolution[1685:10303] Display 0: 1600x1200x32@60 21:47:58 INFO - 2016-04-13 21:47:58.346 screenresolution[1686:10306] starting screenresolution argv=screenresolution list 21:47:58 INFO - Available Modes on Display 0 21:47:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:47:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:47:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:47:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:47:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:47:58 INFO - Intel Iris: 21:47:58 INFO - Chipset Model: Intel Iris 21:47:58 INFO - Type: GPU 21:47:58 INFO - Bus: Built-In 21:47:58 INFO - VRAM (Dynamic, Max): 1536 MB 21:47:58 INFO - Vendor: Intel (0x8086) 21:47:58 INFO - Device ID: 0x0a2e 21:47:58 INFO - Revision ID: 0x0009 21:47:58 INFO - Displays: 21:47:58 INFO - Display: 21:47:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:47:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:47:58 INFO - Display Serial Number: 1600x1200 60 21:47:58 INFO - Main Display: Yes 21:47:58 INFO - Mirror: Off 21:47:58 INFO - Online: Yes 21:47:58 INFO - Rotation: Supported 21:47:58 INFO - Return code: 0 21:47:58 INFO - Running post-action listener: _resource_record_post_action 21:47:58 INFO - Running post-run listener: _resource_record_post_run 21:47:59 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37717504; Write bytes: 696446464; Read time: 460; Write time: 1933 21:47:59 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 387416576; Write bytes: 381552640; Read time: 29719; Write time: 685 21:47:59 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 35894784; Write bytes: 299484672; Read time: 439; Write time: 1211 21:47:59 INFO - Running post-run listener: _upload_blobber_files 21:47:59 INFO - Blob upload gear active. 21:47:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:47:59 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 21:47:59 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:47:59 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:48:00 INFO - (blobuploader) - INFO - Open directory for files ... 21:48:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:48:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:48:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:48:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:48:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:48:01 INFO - (blobuploader) - INFO - Done attempting. 21:48:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:48:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:48:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:48:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:48:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:48:02 INFO - (blobuploader) - INFO - Done attempting. 21:48:02 INFO - (blobuploader) - INFO - Iteration through files over. 21:48:02 INFO - Return code: 0 21:48:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:48:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:48:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69f4035823581a189b8861052fa1bc0c33febadfb4646303b121f66dcde99def8589e718515d0043504a7fbdd3a67d40e3987d9e5e04cc3203997c7ea294f904", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a40982d7e786828a4fbbd811a01e351ec15e924c0e91cb6a0f97a8dcf8fb4ba9f483d5c6aafe12f5dce950966c8b9c4823264b92d33b1e2ce7f8c40454bd32f"} 21:48:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:48:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:48:02 INFO - Contents: 21:48:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69f4035823581a189b8861052fa1bc0c33febadfb4646303b121f66dcde99def8589e718515d0043504a7fbdd3a67d40e3987d9e5e04cc3203997c7ea294f904", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a40982d7e786828a4fbbd811a01e351ec15e924c0e91cb6a0f97a8dcf8fb4ba9f483d5c6aafe12f5dce950966c8b9c4823264b92d33b1e2ce7f8c40454bd32f"} 21:48:02 INFO - Running post-run listener: copy_logs_to_upload_dir 21:48:02 INFO - Copying logs to upload dir... 21:48:02 INFO - mkdir: /builds/slave/test/build/upload/logs 21:48:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.051788 ========= master_lag: -0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-13 21:48:02.762257) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 21:48:02.767071) ========= 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.xi0FpsdfDB/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.h4x35AdMTC/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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/Fx-Team/sha512/69f4035823581a189b8861052fa1bc0c33febadfb4646303b121f66dcde99def8589e718515d0043504a7fbdd3a67d40e3987d9e5e04cc3203997c7ea294f904", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a40982d7e786828a4fbbd811a01e351ec15e924c0e91cb6a0f97a8dcf8fb4ba9f483d5c6aafe12f5dce950966c8b9c4823264b92d33b1e2ce7f8c40454bd32f"} build_url:https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/BBhifZ4GRFiN7NgYGbZiyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69f4035823581a189b8861052fa1bc0c33febadfb4646303b121f66dcde99def8589e718515d0043504a7fbdd3a67d40e3987d9e5e04cc3203997c7ea294f904", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a40982d7e786828a4fbbd811a01e351ec15e924c0e91cb6a0f97a8dcf8fb4ba9f483d5c6aafe12f5dce950966c8b9c4823264b92d33b1e2ce7f8c40454bd32f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 21:48:02.796813) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 21:48:02.797093) ========= 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.xi0FpsdfDB/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.h4x35AdMTC/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005034 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 21:48:02.845145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 21:48:02.845410) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 21:48:02.848746) ========= ========= Total master_lag: 0.11 =========