builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0085 starttime: 1456391076.15 results: success (0) buildid: 20160225000028 builduid: 767100ea46a746f08a0535674ee9ac24 revision: 0d9fb568358e60b681bff1ca177da3544d5001ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 01:04:36.150731) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 01:04:36.151136) ========= ========= Started set props: basedir (results: 0, elapsed: 4 secs) (at 2016-02-25 01:04:36.151416) ========= 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.C2T0D58UBJ/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.CjnKssxtOK/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005601 basedir: '/builds/slave/test' ========= master_lag: 4.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 4 secs) (at 2016-02-25 01:04:40.172946) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 8 secs) (at 2016-02-25 01:04:40.173261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 8 secs) (at 2016-02-25 01:04:48.717238) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-02-25 01:04:48.717566) ========= 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.C2T0D58UBJ/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.CjnKssxtOK/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.006038 ========= master_lag: 4.81 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-02-25 01:04:53.532516) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 01:04:53.532773) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 01:04:53.536156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 01:04:53.536433) ========= 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.C2T0D58UBJ/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.CjnKssxtOK/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-25 01:04: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% 173M=0s 2016-02-25 01:04:54 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.673811 ========= master_lag: 0.43 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 01:04:54.644471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:04:54.644755) ========= 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.C2T0D58UBJ/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.CjnKssxtOK/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.026907 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:04:54.763402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-25 01:04:54.763695) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0d9fb568358e60b681bff1ca177da3544d5001ad --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 0d9fb568358e60b681bff1ca177da3544d5001ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C2T0D58UBJ/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.CjnKssxtOK/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-25 01:04:54,850 truncating revision to first 12 chars 2016-02-25 01:04:54,850 Setting DEBUG logging. 2016-02-25 01:04:54,851 attempt 1/10 2016-02-25 01:04:54,851 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0d9fb568358e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 01:04:55,467 unpacking tar archive at: fx-team-0d9fb568358e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.871313 ========= master_lag: 3.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-25 01:04:58.913165) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 01:04:58.913572) ========= echo 0d9fb568358e60b681bff1ca177da3544d5001ad in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0d9fb568358e60b681bff1ca177da3544d5001ad'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C2T0D58UBJ/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.CjnKssxtOK/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 0d9fb568358e60b681bff1ca177da3544d5001ad program finished with exit code 0 elapsedTime=0.005972 script_repo_revision: '0d9fb568358e60b681bff1ca177da3544d5001ad' ========= master_lag: 0.98 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 01:04:59.901513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 01:04:59.901779) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 01:04:59.971098) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-02-25 01:04:59.971354) ========= /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.C2T0D58UBJ/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.CjnKssxtOK/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 01:05:00 INFO - MultiFileLogger online at 20160225 01:05:00 in /builds/slave/test 01:05:00 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 01:05:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:05:00 INFO - {'append_to_log': False, 01:05:00 INFO - 'base_work_dir': '/builds/slave/test', 01:05:00 INFO - 'blob_upload_branch': 'Fx-Team', 01:05:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:05:00 INFO - 'branch': 'Fx-Team', 01:05:00 INFO - 'buildbot_json_path': 'buildprops.json', 01:05:00 INFO - 'config_files': ('talos/mac_config.py',), 01:05:00 INFO - 'default_actions': ('clobber', 01:05:00 INFO - 'read-buildbot-config', 01:05:00 INFO - 'download-and-extract', 01:05:00 INFO - 'populate-webroot', 01:05:00 INFO - 'create-virtualenv', 01:05:00 INFO - 'install', 01:05:00 INFO - 'run-tests'), 01:05:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:05:00 INFO - 'download_minidump_stackwalk': True, 01:05:00 INFO - 'download_symbols': 'ondemand', 01:05:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:05:00 INFO - 'tooltool.py': '/tools/tooltool.py', 01:05:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:05:00 INFO - '/tools/misc-python/virtualenv.py')}, 01:05:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:05:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:05:00 INFO - 'installer_path': 'installer.exe', 01:05:00 INFO - 'log_level': 'info', 01:05:00 INFO - 'log_name': 'talos', 01:05:00 INFO - 'log_to_console': True, 01:05:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:05:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:05:00 INFO - 'opt_config_files': (), 01:05:00 INFO - 'pip_index': False, 01:05:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:05:00 INFO - 'cmd': ('bash', 01:05:00 INFO - '-c', 01:05:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:05:00 INFO - 'enabled': True, 01:05:00 INFO - 'halt_on_failure': False, 01:05:00 INFO - 'name': 'check_screen_resolution'},), 01:05:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:05:00 INFO - 'cmd': ('bash', 01:05:00 INFO - '-c', 01:05:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:05:00 INFO - 'enabled': True, 01:05:00 INFO - 'halt_on_failure': False, 01:05:00 INFO - 'name': 'check_screen_resolution'},), 01:05:00 INFO - 'run_cmd_checks_enabled': True, 01:05:00 INFO - 'sps_profile': False, 01:05:00 INFO - 'sps_profile_interval': 0, 01:05:00 INFO - 'suite': 'dromaeojs-e10s', 01:05:00 INFO - 'system_bits': '32', 01:05:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:05:00 INFO - 'title': 't-yosemite-r7-0085', 01:05:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:05:00 INFO - 'use_talos_json': True, 01:05:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:05:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:05:00 INFO - 'work_dir': 'build'} 01:05:00 INFO - ##### 01:05:00 INFO - ##### Running clobber step. 01:05:00 INFO - ##### 01:05:00 INFO - Running pre-action listener: _resource_record_pre_action 01:05:00 INFO - Running main action method: clobber 01:05:00 INFO - rmtree: /builds/slave/test/build 01:05:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:05:01 INFO - Running post-action listener: _resource_record_post_action 01:05:01 INFO - ##### 01:05:01 INFO - ##### Running read-buildbot-config step. 01:05:01 INFO - ##### 01:05:01 INFO - Running pre-action listener: _resource_record_pre_action 01:05:01 INFO - Running main action method: read_buildbot_config 01:05:01 INFO - Using buildbot properties: 01:05:01 INFO - { 01:05:01 INFO - "project": "", 01:05:01 INFO - "product": "firefox", 01:05:01 INFO - "script_repo_revision": "production", 01:05:01 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 01:05:01 INFO - "repository": "", 01:05:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 01:05:01 INFO - "buildid": "20160225000028", 01:05:01 INFO - "pgo_build": "False", 01:05:01 INFO - "basedir": "/builds/slave/test", 01:05:01 INFO - "buildnumber": 447, 01:05:01 INFO - "slavename": "t-yosemite-r7-0085", 01:05:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:05:01 INFO - "platform": "yosemite_r7", 01:05:01 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:05:01 INFO - "branch": "fx-team", 01:05:01 INFO - "repo_path": "integration/fx-team", 01:05:01 INFO - "revision": "0d9fb568358e60b681bff1ca177da3544d5001ad", 01:05:01 INFO - "stage_platform": "macosx64", 01:05:01 INFO - "builduid": "767100ea46a746f08a0535674ee9ac24", 01:05:01 INFO - "slavebuilddir": "test" 01:05:01 INFO - } 01:05:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 01:05:01 INFO - Running post-action listener: _resource_record_post_action 01:05:01 INFO - ##### 01:05:01 INFO - ##### Running download-and-extract step. 01:05:01 INFO - ##### 01:05:01 INFO - Running pre-action listener: _resource_record_pre_action 01:05:01 INFO - Running main action method: download_and_extract 01:05:01 INFO - mkdir: /builds/slave/test/build/tests 01:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:01 INFO - https://queue.taskcluster.net/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:05:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/test_packages.json 01:05:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/test_packages.json 01:05:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:05:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:05:02 INFO - Downloaded 1277 bytes. 01:05:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:05:02 INFO - Using the following test package requirements: 01:05:02 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:05:02 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:05:02 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 01:05:02 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:05:02 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 01:05:02 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:05:02 INFO - u'jsshell-mac.zip'], 01:05:02 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:05:02 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 01:05:02 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:05:02 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:05:02 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 01:05:02 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:05:02 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 01:05:02 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:05:02 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 01:05:02 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:05:02 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:05:02 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 01:05:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:05:02 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')]} 01:05:02 INFO - https://queue.taskcluster.net/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:05:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:05:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:05:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:05:10 INFO - Downloaded 17828775 bytes. 01:05:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:05:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:05:13 INFO - Return code: 0 01:05:13 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:05:13 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')]} 01:05:13 INFO - https://queue.taskcluster.net/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:05:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:05:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:05:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:05:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:05:14 INFO - Downloaded 17828775 bytes. 01:05:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:05:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:05:17 INFO - Return code: 0 01:05:17 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')]} 01:05:17 INFO - https://queue.taskcluster.net/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:05:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:05:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:05:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:05:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:05:18 INFO - Downloaded 10707015 bytes. 01:05:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:05:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:05:18 INFO - Return code: 0 01:05: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')]} 01:05:18 INFO - https://queue.taskcluster.net/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:05:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:05:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:05:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 01:05:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 01:05:22 INFO - Downloaded 111442557 bytes. 01:05:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:05:22 INFO - mkdir: /builds/slave/test/properties 01:05:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:05:22 INFO - Writing to file /builds/slave/test/properties/build_url 01:05:22 INFO - Contents: 01:05:22 INFO - build_url:https://queue.taskcluster.net/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:05:23 INFO - Running post-action listener: _resource_record_post_action 01:05:23 INFO - Running post-action listener: set_extra_try_arguments 01:05:23 INFO - ##### 01:05:23 INFO - ##### Running populate-webroot step. 01:05:23 INFO - ##### 01:05:23 INFO - Running pre-action listener: _resource_record_pre_action 01:05:23 INFO - Running main action method: populate_webroot 01:05:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:05:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:05:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:05:23 INFO - '--tppagecycles', 01:05:23 INFO - '7'], 01:05:23 INFO - 'tests': ['tsvgm']}}, 01:05:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:05:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:05:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:05:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:05:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:05:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:05:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:05:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:23 INFO - 'talos_options': ['--e10s'], 01:05:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:05:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:23 INFO - 'tests': ['damp', 'tps']}, 01:05:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:23 INFO - 'talos_options': ['--e10s'], 01:05:23 INFO - 'tests': ['damp', 'tps']}, 01:05:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:05:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:05:23 INFO - 'other': {'tests': ['a11yr', 01:05:23 INFO - 'ts_paint', 01:05:23 INFO - 'tpaint', 01:05:23 INFO - 'sessionrestore', 01:05:23 INFO - 'sessionrestore_no_auto_restore']}, 01:05:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:05:23 INFO - 'tests': ['a11yr', 01:05:23 INFO - 'ts_paint', 01:05:23 INFO - 'tpaint', 01:05:23 INFO - 'sessionrestore', 01:05:23 INFO - 'sessionrestore_no_auto_restore']}, 01:05:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:05:23 INFO - 'tests': ['a11yr', 01:05:23 INFO - 'ts_paint', 01:05:23 INFO - 'tpaint', 01:05:23 INFO - 'sessionrestore', 01:05:23 INFO - 'sessionrestore_no_auto_restore']}, 01:05:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:05:23 INFO - 'tests': ['a11yr', 01:05:23 INFO - 'ts_paint', 01:05:23 INFO - 'tpaint', 01:05:23 INFO - 'sessionrestore', 01:05:23 INFO - 'sessionrestore_no_auto_restore']}, 01:05:23 INFO - 'other_l64': {'tests': ['a11yr', 01:05:23 INFO - 'ts_paint', 01:05:23 INFO - 'tpaint', 01:05:23 INFO - 'sessionrestore', 01:05:23 INFO - 'sessionrestore_no_auto_restore']}, 01:05:23 INFO - 'other_nol64': {'tests': ['a11yr', 01:05:23 INFO - 'ts_paint', 01:05:23 INFO - 'tpaint', 01:05:23 INFO - 'sessionrestore', 01:05:23 INFO - 'sessionrestore_no_auto_restore']}, 01:05:23 INFO - 'svgr': {'tests': ['tsvgx', 01:05:23 INFO - 'tsvgr_opacity', 01:05:23 INFO - 'tart', 01:05:23 INFO - 'tscrollx', 01:05:23 INFO - 'cart']}, 01:05:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:05:23 INFO - 'tests': ['tsvgx', 01:05:23 INFO - 'tsvgr_opacity', 01:05:23 INFO - 'tart', 01:05:23 INFO - 'tscrollx', 01:05:23 INFO - 'cart']}, 01:05:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:23 INFO - 'tests': ['tp5o']}, 01:05:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:23 INFO - 'talos_options': ['--e10s'], 01:05:23 INFO - 'tests': ['tp5o']}, 01:05:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:23 INFO - 'talos_options': ['--xperf_path', 01:05:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:05:23 INFO - 'tests': ['tp5n']}, 01:05:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:23 INFO - 'talos_options': ['--e10s', 01:05:23 INFO - '--xperf_path', 01:05:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:05:23 INFO - 'tests': ['tp5n']}}, 01:05:23 INFO - 'talos.zip': {'path': '', 01:05:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:05:23 INFO - Running post-action listener: _resource_record_post_action 01:05:23 INFO - ##### 01:05:23 INFO - ##### Running create-virtualenv step. 01:05:23 INFO - ##### 01:05:23 INFO - Running pre-action listener: _resource_record_pre_action 01:05:23 INFO - Running main action method: create_virtualenv 01:05:23 INFO - Creating virtualenv /builds/slave/test/build/venv 01:05:23 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 01:05:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:05:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:05:23 INFO - Using real prefix '/tools/python27' 01:05:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:05:24 INFO - Installing distribute.............................................................................................................................................................................................done. 01:05:27 INFO - Installing pip.................done. 01:05:27 INFO - Return code: 0 01:05:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:27 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 0x10650ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe660c8f320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063afd30>, '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 0x1061d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063a6b20>, '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.C2T0D58UBJ/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.CjnKssxtOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 01:05:27 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 01:05:27 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 01:05:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C2T0D58UBJ/Render', 01:05:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:05:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:05:27 INFO - 'HOME': '/Users/cltbld', 01:05:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:05:27 INFO - 'LOGNAME': 'cltbld', 01:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:27 INFO - 'MOZ_NO_REMOTE': '1', 01:05:27 INFO - 'NO_EM_RESTART': '1', 01:05:27 INFO - 'PAGER': '/bin/cat', 01:05:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:27 INFO - 'PWD': '/builds/slave/test', 01:05:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:05:27 INFO - 'SHELL': '/bin/bash', 01:05:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CjnKssxtOK/Listeners', 01:05:27 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 01:05:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:05:27 INFO - 'USER': 'cltbld', 01:05:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:05:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:27 INFO - 'XPC_FLAGS': '0x0', 01:05:27 INFO - 'XPC_SERVICE_NAME': '0', 01:05:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:27 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 01:05:27 INFO - Cleaning up... 01:05:27 INFO - Return code: 0 01:05:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:27 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 0x10650ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe660c8f320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063afd30>, '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 0x1061d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063a6b20>, '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.C2T0D58UBJ/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.CjnKssxtOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 01:05:27 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 01:05:27 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 01:05:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C2T0D58UBJ/Render', 01:05:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:05:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:05:27 INFO - 'HOME': '/Users/cltbld', 01:05:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:05:27 INFO - 'LOGNAME': 'cltbld', 01:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:27 INFO - 'MOZ_NO_REMOTE': '1', 01:05:27 INFO - 'NO_EM_RESTART': '1', 01:05:27 INFO - 'PAGER': '/bin/cat', 01:05:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:27 INFO - 'PWD': '/builds/slave/test', 01:05:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:05:27 INFO - 'SHELL': '/bin/bash', 01:05:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CjnKssxtOK/Listeners', 01:05:27 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 01:05:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:05:27 INFO - 'USER': 'cltbld', 01:05:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:05:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:27 INFO - 'XPC_FLAGS': '0x0', 01:05:27 INFO - 'XPC_SERVICE_NAME': '0', 01:05:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:27 INFO - Downloading/unpacking psutil>=0.7.1 01:05:27 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 01:05:27 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 01:05:27 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 01:05:27 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 01:05:27 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 01:05:27 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 01:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:05:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:05:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:05:30 INFO - Installing collected packages: psutil 01:05:30 INFO - Running setup.py install for psutil 01:05:30 INFO - building 'psutil._psutil_osx' extension 01:05:30 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 01:05:31 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 01:05:31 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 01:05:31 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 01:05:31 INFO - building 'psutil._psutil_posix' extension 01:05:31 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 01:05:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:05:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:05:31 INFO - ^ 01:05:31 INFO - 1 warning generated. 01:05:31 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 01:05:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:05:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:05:31 INFO - Successfully installed psutil 01:05:31 INFO - Cleaning up... 01:05:31 INFO - Return code: 0 01:05:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:05: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')]} 01:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:32 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')]} 01:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:32 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 0x10650ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe660c8f320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063afd30>, '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 0x1061d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063a6b20>, '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.C2T0D58UBJ/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.CjnKssxtOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 01:05:32 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 01:05:32 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 01:05:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C2T0D58UBJ/Render', 01:05:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:05:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:05:32 INFO - 'HOME': '/Users/cltbld', 01:05:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:05:32 INFO - 'LOGNAME': 'cltbld', 01:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:32 INFO - 'MOZ_NO_REMOTE': '1', 01:05:32 INFO - 'NO_EM_RESTART': '1', 01:05:32 INFO - 'PAGER': '/bin/cat', 01:05:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:32 INFO - 'PWD': '/builds/slave/test', 01:05:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:05:32 INFO - 'SHELL': '/bin/bash', 01:05:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CjnKssxtOK/Listeners', 01:05:32 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 01:05:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:05:32 INFO - 'USER': 'cltbld', 01:05:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:05:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:32 INFO - 'XPC_FLAGS': '0x0', 01:05:32 INFO - 'XPC_SERVICE_NAME': '0', 01:05:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:05:32 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 01:05:32 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 01:05:32 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 01:05:32 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 01:05:32 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 01:05:32 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 01:05:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:05:34 INFO - Installing collected packages: mozsystemmonitor 01:05:34 INFO - Running setup.py install for mozsystemmonitor 01:05:34 INFO - Successfully installed mozsystemmonitor 01:05:34 INFO - Cleaning up... 01:05:34 INFO - Return code: 0 01:05:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:05:34 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')]} 01:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:34 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')]} 01:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:34 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 0x10650ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe660c8f320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063afd30>, '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 0x1061d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063a6b20>, '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.C2T0D58UBJ/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.CjnKssxtOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 01:05:34 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 01:05:34 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 01:05:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C2T0D58UBJ/Render', 01:05:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:05:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:05:34 INFO - 'HOME': '/Users/cltbld', 01:05:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:05:34 INFO - 'LOGNAME': 'cltbld', 01:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:34 INFO - 'MOZ_NO_REMOTE': '1', 01:05:34 INFO - 'NO_EM_RESTART': '1', 01:05:34 INFO - 'PAGER': '/bin/cat', 01:05:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:34 INFO - 'PWD': '/builds/slave/test', 01:05:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:05:34 INFO - 'SHELL': '/bin/bash', 01:05:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CjnKssxtOK/Listeners', 01:05:34 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 01:05:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:05:34 INFO - 'USER': 'cltbld', 01:05:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:05:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:34 INFO - 'XPC_FLAGS': '0x0', 01:05:34 INFO - 'XPC_SERVICE_NAME': '0', 01:05:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:35 INFO - Downloading/unpacking blobuploader==1.2.4 01:05:35 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 01:05:35 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 01:05:35 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 01:05:35 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 01:05:35 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 01:05:35 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 01:05:37 INFO - Downloading blobuploader-1.2.4.tar.gz 01:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:05:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:05: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 01:05: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 01:05: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 01:05: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 01:05: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 01:05: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 01:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:05:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:05:38 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 01:05:38 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 01:05:38 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 01:05:38 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 01:05:38 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 01:05:38 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 01:05:38 INFO - Downloading docopt-0.6.1.tar.gz 01:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:05:38 INFO - Installing collected packages: blobuploader, requests, docopt 01:05:38 INFO - Running setup.py install for blobuploader 01:05:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:05:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:05:38 INFO - Running setup.py install for requests 01:05:39 INFO - Running setup.py install for docopt 01:05:39 INFO - Successfully installed blobuploader requests docopt 01:05:39 INFO - Cleaning up... 01:05:39 INFO - Return code: 0 01:05:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:39 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 0x10650ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe660c8f320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063afd30>, '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 0x1061d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063a6b20>, '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.C2T0D58UBJ/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.CjnKssxtOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 01:05:39 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 01:05:39 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 01:05:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C2T0D58UBJ/Render', 01:05:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:05:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:05:39 INFO - 'HOME': '/Users/cltbld', 01:05:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:05:39 INFO - 'LOGNAME': 'cltbld', 01:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:39 INFO - 'MOZ_NO_REMOTE': '1', 01:05:39 INFO - 'NO_EM_RESTART': '1', 01:05:39 INFO - 'PAGER': '/bin/cat', 01:05:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:39 INFO - 'PWD': '/builds/slave/test', 01:05:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:05:39 INFO - 'SHELL': '/bin/bash', 01:05:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CjnKssxtOK/Listeners', 01:05:39 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 01:05:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:05:39 INFO - 'USER': 'cltbld', 01:05:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:05:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:39 INFO - 'XPC_FLAGS': '0x0', 01:05:39 INFO - 'XPC_SERVICE_NAME': '0', 01:05:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:05:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-HC8QdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:05:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-1gBucm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:05:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-ygf0JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:05:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-kmCcVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:05:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-W6AxhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:05:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-uXO1YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:05:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-_e7nEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:05:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Z5pMgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:05:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-xublzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:05:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-tWEDA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:05:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-zvoxHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:05:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-4apKPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:05:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-4tkOwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:05:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-xKHwBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-UopfB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:05:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Nrxyss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:05:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-MpfAMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:05:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:05:41 INFO - Running setup.py install for manifestparser 01:05:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:05:41 INFO - Running setup.py install for mozcrash 01:05:41 INFO - Running setup.py install for mozdebug 01:05:42 INFO - Running setup.py install for mozdevice 01:05:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:05:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:05:42 INFO - Running setup.py install for mozfile 01:05:42 INFO - Running setup.py install for mozhttpd 01:05:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:05:42 INFO - Running setup.py install for mozinfo 01:05:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:05:42 INFO - Running setup.py install for mozInstall 01:05:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:05:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:05:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:05:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:05:42 INFO - Running setup.py install for mozleak 01:05:43 INFO - Running setup.py install for mozlog 01:05:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:05:43 INFO - Running setup.py install for moznetwork 01:05:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:05:43 INFO - Running setup.py install for mozprocess 01:05:43 INFO - Running setup.py install for mozprofile 01:05:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:05:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:05:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:05:43 INFO - Running setup.py install for mozrunner 01:05:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:05:43 INFO - Running setup.py install for mozscreenshot 01:05:43 INFO - Running setup.py install for moztest 01:05:44 INFO - Running setup.py install for mozversion 01:05:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:05:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:05:44 INFO - Cleaning up... 01:05:44 INFO - Return code: 0 01:05:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:05: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')]} 01:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05: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')]} 01:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:44 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 0x10650ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe660c8f320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063afd30>, '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 0x1061d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063a6b20>, '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.C2T0D58UBJ/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.CjnKssxtOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 01:05:44 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 01:05:44 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 01:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C2T0D58UBJ/Render', 01:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:05:44 INFO - 'HOME': '/Users/cltbld', 01:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:05:44 INFO - 'LOGNAME': 'cltbld', 01:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:44 INFO - 'MOZ_NO_REMOTE': '1', 01:05:44 INFO - 'NO_EM_RESTART': '1', 01:05:44 INFO - 'PAGER': '/bin/cat', 01:05:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:44 INFO - 'PWD': '/builds/slave/test', 01:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:05:44 INFO - 'SHELL': '/bin/bash', 01:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CjnKssxtOK/Listeners', 01:05:44 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 01:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:05:44 INFO - 'USER': 'cltbld', 01:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:44 INFO - 'XPC_FLAGS': '0x0', 01:05:44 INFO - 'XPC_SERVICE_NAME': '0', 01:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:05:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-h_hpUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:05:44 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)) 01:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:05:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Tx5ES_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:05:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-h6AY6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:05:44 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)) 01:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:05:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-zoeErB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:05:44 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)) 01:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:05:44 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-zYcUS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:05:45 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)) 01:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:05:45 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-FXAb9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:05:45 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)) 01:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:05:45 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-WOCrNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:05:45 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)) 01:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:05:45 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-qW19WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:05:45 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)) 01:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:05:45 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-n9MQ_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:05:45 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)) 01:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:05:45 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-hJnKok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:05:45 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)) 01:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:05:45 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-wjKe2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:05:45 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)) 01:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:05:45 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-GGWNs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:05:45 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)) 01:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:05:45 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-NnsDVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:05:45 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)) 01:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:05:45 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-vt2BJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:05:46 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)) 01:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:46 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-AT5kPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:46 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)) 01:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:05:46 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-IX_kmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:05:46 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)) 01:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:05:46 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-yLVIqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:05:46 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)) 01:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:05:46 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)) 01:05:46 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)) 01:05:46 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)) 01:05:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:48 INFO - Downloading blessings-1.6.tar.gz 01:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:05:48 INFO - Installing collected packages: blessings 01:05:48 INFO - Running setup.py install for blessings 01:05:48 INFO - Successfully installed blessings 01:05:48 INFO - Cleaning up... 01:05:49 INFO - Return code: 0 01:05:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:05:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:05:49 INFO - Reading from file tmpfile_stdout 01:05:49 INFO - Current package versions: 01:05:49 INFO - blessings == 1.6 01:05:49 INFO - blobuploader == 1.2.4 01:05:49 INFO - docopt == 0.6.1 01:05:49 INFO - manifestparser == 1.1 01:05:49 INFO - mozInstall == 1.12 01:05:49 INFO - mozcrash == 0.16 01:05:49 INFO - mozdebug == 0.1 01:05:49 INFO - mozdevice == 0.48 01:05:49 INFO - mozfile == 1.2 01:05:49 INFO - mozhttpd == 0.7 01:05:49 INFO - mozinfo == 0.9 01:05:49 INFO - mozleak == 0.1 01:05:49 INFO - mozlog == 3.1 01:05:49 INFO - moznetwork == 0.27 01:05:49 INFO - mozprocess == 0.22 01:05:49 INFO - mozprofile == 0.28 01:05:49 INFO - mozrunner == 6.11 01:05:49 INFO - mozscreenshot == 0.1 01:05:49 INFO - mozsystemmonitor == 0.0 01:05:49 INFO - moztest == 0.7 01:05:49 INFO - mozversion == 1.4 01:05:49 INFO - psutil == 3.1.1 01:05:49 INFO - requests == 1.2.3 01:05:49 INFO - wsgiref == 0.1.2 01:05:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:05:49 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')]} 01:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:49 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')]} 01:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:49 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 0x10650ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe660c8f320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063afd30>, '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 0x1061d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063a6b20>, '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.C2T0D58UBJ/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.CjnKssxtOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 01:05:49 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 01:05:49 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 01:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C2T0D58UBJ/Render', 01:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:05:49 INFO - 'HOME': '/Users/cltbld', 01:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:05:49 INFO - 'LOGNAME': 'cltbld', 01:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:49 INFO - 'MOZ_NO_REMOTE': '1', 01:05:49 INFO - 'NO_EM_RESTART': '1', 01:05:49 INFO - 'PAGER': '/bin/cat', 01:05:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:49 INFO - 'PWD': '/builds/slave/test', 01:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:05:49 INFO - 'SHELL': '/bin/bash', 01:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CjnKssxtOK/Listeners', 01:05:49 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 01:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:05:49 INFO - 'USER': 'cltbld', 01:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:49 INFO - 'XPC_FLAGS': '0x0', 01:05:49 INFO - 'XPC_SERVICE_NAME': '0', 01:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:49 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)) 01:05:49 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)) 01:05:49 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)) 01:05:49 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)) 01:05:49 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)) 01:05:49 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)) 01:05:49 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)) 01:05:49 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)) 01:05:49 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)) 01:05:49 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)) 01:05:49 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)) 01:05:49 INFO - Cleaning up... 01:05:49 INFO - Return code: 0 01:05:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:05:49 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')]} 01:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:49 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')]} 01:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:49 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 0x10650ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe660c8f320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063afd30>, '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 0x1061d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063a6b20>, '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.C2T0D58UBJ/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.CjnKssxtOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 01:05:49 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 01:05:49 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 01:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C2T0D58UBJ/Render', 01:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:05:49 INFO - 'HOME': '/Users/cltbld', 01:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:05:49 INFO - 'LOGNAME': 'cltbld', 01:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:49 INFO - 'MOZ_NO_REMOTE': '1', 01:05:49 INFO - 'NO_EM_RESTART': '1', 01:05:49 INFO - 'PAGER': '/bin/cat', 01:05:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:49 INFO - 'PWD': '/builds/slave/test', 01:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:05:49 INFO - 'SHELL': '/bin/bash', 01:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CjnKssxtOK/Listeners', 01:05:49 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 01:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:05:49 INFO - 'USER': 'cltbld', 01:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:49 INFO - 'XPC_FLAGS': '0x0', 01:05:49 INFO - 'XPC_SERVICE_NAME': '0', 01:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:49 INFO - Downloading/unpacking jsonschema 01:05:49 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 01:05:49 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 01:05:49 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 01:05:49 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 01:05:49 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 01:05:49 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 01:05:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:05:52 INFO - Downloading/unpacking functools32 (from jsonschema) 01:05:52 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 01:05:52 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 01:05:52 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 01:05:52 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 01:05:52 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 01:05:52 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 01:05:52 INFO - Downloading functools32-3.2.3-2.tar.gz 01:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:05:52 INFO - warning: no files found matching '*.txt' 01:05:52 INFO - no previously-included directories found matching 'build' 01:05:52 INFO - no previously-included directories found matching 'dist' 01:05:52 INFO - no previously-included directories found matching '.git*' 01:05:52 INFO - Installing collected packages: jsonschema, functools32 01:05:52 INFO - Running setup.py install for functools32 01:05:52 INFO - warning: no files found matching '*.txt' 01:05:52 INFO - no previously-included directories found matching 'build' 01:05:52 INFO - no previously-included directories found matching 'dist' 01:05:52 INFO - no previously-included directories found matching '.git*' 01:05:52 INFO - Successfully installed jsonschema functools32 01:05:52 INFO - Cleaning up... 01:05:52 INFO - Return code: 0 01:05:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:52 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 0x10650ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe660c8f320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063afd30>, '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 0x1061d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063a6b20>, '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.C2T0D58UBJ/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.CjnKssxtOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 01:05:52 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 01:05:52 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 01:05:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C2T0D58UBJ/Render', 01:05:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:05:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:05:52 INFO - 'HOME': '/Users/cltbld', 01:05:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:05:52 INFO - 'LOGNAME': 'cltbld', 01:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:52 INFO - 'MOZ_NO_REMOTE': '1', 01:05:52 INFO - 'NO_EM_RESTART': '1', 01:05:52 INFO - 'PAGER': '/bin/cat', 01:05:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:52 INFO - 'PWD': '/builds/slave/test', 01:05:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:05:52 INFO - 'SHELL': '/bin/bash', 01:05:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CjnKssxtOK/Listeners', 01:05:52 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 01:05:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:05:52 INFO - 'USER': 'cltbld', 01:05:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:05:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:52 INFO - 'XPC_FLAGS': '0x0', 01:05:52 INFO - 'XPC_SERVICE_NAME': '0', 01:05:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:53 INFO - Downloading/unpacking flake8 01:05:53 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 01:05:53 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 01:05:53 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 01:05:53 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 01:05:53 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 01:05:53 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 01:05:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:05:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:05:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:05:56 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 01:05:56 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 01:05:56 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 01:05:56 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 01:05:56 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 01:05:56 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 01:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:05:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:05:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:05:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:05:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:05:56 INFO - no previously-included directories found matching 'docs/_build' 01:05:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:05:56 INFO - Running setup.py install for pep8 01:05:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:05:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:05:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:05:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:05:56 INFO - no previously-included directories found matching 'docs/_build' 01:05:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:05:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:05:57 INFO - Cleaning up... 01:05:57 INFO - Return code: 0 01:05:57 INFO - Running post-action listener: _resource_record_post_action 01:05:57 INFO - Running post-action listener: _start_resource_monitoring 01:05:57 INFO - Starting resource monitoring. 01:05:57 INFO - ##### 01:05:57 INFO - ##### Running install step. 01:05:57 INFO - ##### 01:05:57 INFO - Running pre-action listener: _resource_record_pre_action 01:05:57 INFO - Running main action method: install 01:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:05:57 INFO - Reading from file tmpfile_stdout 01:05:57 INFO - Detecting whether we're running mozinstall >=1.0... 01:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:05:57 INFO - Reading from file tmpfile_stdout 01:05:57 INFO - Output received: 01:05:57 INFO - Usage: mozinstall [options] installer 01:05:57 INFO - Options: 01:05:57 INFO - -h, --help show this help message and exit 01:05:57 INFO - -d DEST, --destination=DEST 01:05:57 INFO - Directory to install application into. [default: 01:05:57 INFO - "/builds/slave/test"] 01:05:57 INFO - --app=APP Application being installed. [default: firefox] 01:05:57 INFO - mkdir: /builds/slave/test/build/application 01:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:06:31 INFO - Reading from file tmpfile_stdout 01:06:31 INFO - Output received: 01:06:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:06:31 INFO - Running post-action listener: _resource_record_post_action 01:06:31 INFO - ##### 01:06:31 INFO - ##### Running run-tests step. 01:06:31 INFO - ##### 01:06:31 INFO - Running pre-action listener: _resource_record_pre_action 01:06:31 INFO - Running main action method: run_tests 01:06:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:06:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:06:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:06:31 INFO - 2016-02-25 01:06:31.870 screenresolution[1653:8315] starting screenresolution argv=screenresolution get 01:06:31 INFO - 2016-02-25 01:06:31.872 screenresolution[1653:8315] Display 0: 1600x1200x32@60 01:06:31 INFO - 2016-02-25 01:06:31.878 screenresolution[1654:8317] starting screenresolution argv=screenresolution list 01:06:31 INFO - Available Modes on Display 0 01:06:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:06:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:06:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:06:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:06:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:06:32 INFO - Intel Iris: 01:06:32 INFO - Chipset Model: Intel Iris 01:06:32 INFO - Type: GPU 01:06:32 INFO - Bus: Built-In 01:06:32 INFO - VRAM (Dynamic, Max): 1536 MB 01:06:32 INFO - Vendor: Intel (0x8086) 01:06:32 INFO - Device ID: 0x0a2e 01:06:32 INFO - Revision ID: 0x0009 01:06:32 INFO - Displays: 01:06:32 INFO - Display: 01:06:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:06:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:06:32 INFO - Display Serial Number: 1600x1200 60 01:06:32 INFO - Main Display: Yes 01:06:32 INFO - Mirror: Off 01:06:32 INFO - Online: Yes 01:06:32 INFO - Rotation: Supported 01:06:32 INFO - Return code: 0 01:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:06:32 INFO - Python 2.7.3 01:06:32 INFO - Return code: 0 01:06:32 INFO - grabbing minidump binary from tooltool 01:06:32 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')]} 01:06:32 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 0x1063afd30>, '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 0x1061d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063a6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:06:32 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 01:06:32 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 01:06:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:06:32 INFO - Return code: 0 01:06:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:06:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:06:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:06:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:06:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:06:33 INFO - Return code: 0 01:06:33 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/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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 01:06:33 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/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0085 --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 01:06:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C2T0D58UBJ/Render', 01:06:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:06:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:06:33 INFO - 'HOME': '/Users/cltbld', 01:06:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:06:33 INFO - 'LOGNAME': 'cltbld', 01:06:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:06:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:33 INFO - 'MOZ_NO_REMOTE': '1', 01:06:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:06:33 INFO - 'NO_EM_RESTART': '1', 01:06:33 INFO - 'PAGER': '/bin/cat', 01:06:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:33 INFO - 'PWD': '/builds/slave/test', 01:06:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:06:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:06:33 INFO - 'SHELL': '/bin/bash', 01:06:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CjnKssxtOK/Listeners', 01:06:33 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 01:06:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:06:33 INFO - 'USER': 'cltbld', 01:06:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:06:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:33 INFO - 'XPC_FLAGS': '0x0', 01:06:33 INFO - 'XPC_SERVICE_NAME': '0', 01:06:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:06:33 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/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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 01:06:33 INFO - mozversion application_buildid: 20160225000028 01:06:33 INFO - mozversion application_changeset: 0d9fb568358e60b681bff1ca177da3544d5001ad 01:06:33 INFO - mozversion application_display_name: Nightly 01:06:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:06:33 INFO - mozversion application_name: Firefox 01:06:33 INFO - mozversion application_remotingname: firefox 01:06:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:06:33 INFO - mozversion application_vendor: Mozilla 01:06:33 INFO - mozversion application_version: 47.0a1 01:06:33 INFO - mozversion platform_buildid: 20160225000028 01:06:33 INFO - mozversion platform_changeset: 0d9fb568358e60b681bff1ca177da3544d5001ad 01:06:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:06:33 INFO - mozversion platform_version: 47.0a1 01:06:33 INFO - using testdate: 1456391193 01:06:33 INFO - actual date: 1456391193 01:06:34 INFO - starting webserver on 'localhost:49283' 01:06:34 INFO - SUITE-START | Running 2 tests 01:06:34 INFO - TEST-START | dromaeo_css 01:06:34 INFO - operating with platform_type : mac_ 01:06:34 INFO - Initialising browser for dromaeo_css test... 01:06:34 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmplZvKfa/profile http://localhost:49283/getInfo.html) 01:06:36 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 01:06:36 INFO - PROCESS | 1672 | colorDepth:24 01:06:36 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 01:06:36 INFO - PROCESS | 1672 | __metrics 01:06:37 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:06:37 INFO - TEST-INFO | 1672: exit 0 01:06:37 INFO - Browser initialized. 01:06:37 INFO - Running cycle 1/1 for dromaeo_css test... 01:06:37 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmplZvKfa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:06:49 INFO - PROCESS | 1676 | RSS: Main: 256004096 01:06:49 INFO - PROCESS | 1676 | 01:07:39 INFO - PROCESS | 1676 | 1456391259224 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] 01:09:48 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 01:09:50 INFO - PROCESS | 1676 | RSS: Main: 268353536 01:09:50 INFO - PROCESS | 1676 | 01:12:52 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 01:12:53 INFO - PROCESS | 1676 | RSS: Main: 281378816 01:12:53 INFO - PROCESS | 1676 | 01:15:54 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 01:15:55 INFO - PROCESS | 1676 | RSS: Main: 282083328 01:15:55 INFO - PROCESS | 1676 | 01:18:57 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 01:18:57 INFO - PROCESS | 1676 | RSS: Main: 283176960 01:18:57 INFO - PROCESS | 1676 | 01:22:00 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 01:22:01 INFO - PROCESS | 1676 | RSS: Main: 287879168 01:22:01 INFO - PROCESS | 1676 | 01:25:03 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 01:25:03 INFO - PROCESS | 1676 | RSS: Main: 288133120 01:25:03 INFO - PROCESS | 1676 | 01:25:03 INFO - PROCESS | 1676 | __start_tp_report 01:25:03 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 01:25:03 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 01:25:03 INFO - PROCESS | 1676 | |i|pagename|runs| 01:25:03 INFO - PROCESS | 1676 | |0;dojo.html;3383.1372999885034;3515.859365625375;3546.9822650886726;3569.411047177216;3609.5488063992;4187.769672668002;5644.096944488882;5729.770809167629;5736.110902810061;5754.136879468082;4735.763211839411;5583.58123140764;5718.1136923776885;5720.399358067405;5761;5123.948760512394;5211.400688920766;5217.399999000126;5248.160294352904;5295.841124766263;536.7516846067741;5126.102931986888;5189.766460509267;5200.141976573861;5221.164613661815;4638.953610463903;4787.4494433139935;4998.675086119409;5216.921746173792;5274.182501712241;4735.124002059595;5261.316028916254;5286.735663216824;5306.151015837486;5307.708076055854;5161.690298582097;5184.922226166611;5191.948080519184;5245.318108645852;5269.077911365534;4459.866204013885;4635.7020034390425;5579.191017302509;5598.944010559883;5650.152477128422;6119.827461251236;6182.69086545671;6212.099245609406;6229.159063526411;6237.532185086136;6218.4714299284615;6227.595206311576;6236.875262494725;6238.1266622672865;6241.563090583661;5867;5871.823845284605;5888.852778680524;5903.203067585907;5927.110933360031;4611.5619016193405;6182.721777519932;6219.937800622027;6267.2792628848265;6356.713947872265;5547.97362487933;5818.330891947396;6156.846078847975;6166.290876549254;6191.938080619227;6176.752929882754;6225.844353891189;6240.251169859555;6240.625562466266;6247;5108.463611320758;6106;6145;6158.938410615837;6212.689365531705;6168.9691551541955;6170.7223174957235;6187.81436556904;6219.657918814509;6223.595466294767;3950.012496875781;4792.376990991149;4857.4171099467585;4892.975535122301;4963.5780958618925;4263;4338.934915976263;4381.408509851193;4386.780660966939;4448.822047118079;4571.314302854598;5620.831375058755;5792.333881603585;5854.414558544197;5896.557758168155;6136.243373036893;6211.627302361872;6239.812805615838;6246.187995560548;6251.499880009588;5817;5870.647761134345;5925.140854576149;5931.703414829241;6004.369541198199;5331.253624492574;5367.919481207785;5391.137418013178;5400.567954563626;5411.972940135274;6172.4136207060255;6313.526485513697;6408.679566021773;6412.935870641327;6428.453581445629;5164.948350516597;6227.408396202353;6229.408206220402;6230.221222347207;6248.156498872594;6322.905156422566;6394.648294343856;6395.808125756234;6398.328175541501;6427.839304017437;6096.908546371897;6136.21274067861;6229.096780966644;6231.376862313732;6234.438900498977;6205.472534834409;6216.564840461305;6224.128621992834;6236.688165591793;6239.469645080219;5794.855128621818;6101.065651476929;6161.907571386522;6174.073888916699;6182.196314479089;5131.589472842238;6141.087130295835;6159.384061593805;6161.5686901918225;6164.599301045418;5257.8695580450385;5977.970110149421;6029.397060293935;6046.334903160737;6061.181740464981;5449.64577302474;6016.63900165974;6122.989706698345;6204.348543403058;6212.409821066992;5171.836336824184;5859.267591551056;5938.851528711817;6017.157597936205;6115.847103822262 01:25:03 INFO - PROCESS | 1676 | |1;ext.html;454.0804870137968;468.8171613070903;478.56928764112314;511.9377292118853;535.5581645142757;37460.43809342859;37766.62233377666;37778;37826.62173378269;37925;38695.613043869555;39312.21375572487;39377.60622393775;39423.408648870216;39450.408243876365;9315.534223288842;9450.4802235877;9467.2899532535;9520.571574279174;9551.90448095517;9438.386504877195;9645.228381729445;9695.70912872615;9711.465869377182;9719.902800972006;9702;9721.270904682176;9723.611055557805;9799.804003919953;9802.656907008257;9694.127528522431;9725.41647501145;9768.462734549597;9773.21814254858;9778.55996480153;9554.283428742803;9614.663486778;9682.322237443383;9702.205092057991;9739.659111931049;38369.42445863314;38465.61534384648;38762;38765;38990.80504597487;2721.7550420462057;2735.7811375089946;3433;3750.3436898542645;3837.0407398150464;21675.566488670138;26965.865170674217;27850.442991140266;27865.303367415774;28353.71646283552;2793.9301517462022;2842.0337085391066;2856.9000084997133;2865.885364585435;2909.86905589249;508635;510768;513131.4343428259;514291.9999999963;515382;44586.55413445824;45083;67991;68416.97374539386;68486.65756671184;46024;46027.76986115048;46213.76893115513;46552.83617909512;46635.76682116568;15344.079355238498;15431.151286679116;15661.373545058297;15819.446319378996;15836.28736706851;12315.4458049388;12318.260904345769;12528.498860045678;12536.934360579453;12575.622731318075;14610.707785844224;14625.195614241105;14698.926505367404;14790.778138327934;14865;6182.938170618326;6309.873802523924;6329.240491141;6330.240371155399;6337.4613157882095;916.6287653500343;935.6584846530967;948.2698322291934;982.6216906491053;1016.6238491758097;22561.323160305215;25496.872515637675;29504.704952950626;29713.25716857096;30072;974.6004138303261;1059.9152067834555;1069.8609180806445;1071.50175168547;1095.7644106517137;13548.864511354957;14336.498222562368;14375.065620734827;14429.567112986628;14658.78011829802;509976;519934;520671;521147;521258;45223.773881130386;50991;59690.40309596848;59995.100073498936;61240.69379653073;1244.2472304255975;1355.5797702712389;1384.439302082658;1405.1428628536585;1441.5242969819935;23506;30946.381072378877;30969;31215;31658.525122122726;46233.53766462292;56123;56474.717626411606;56639.15041274467;57295.1405728906;480352;485789;489235;493353;494467;41779.7911010443;44120.55879441164;44694.77652611716;44906;45062.87342816456;44859.55140448554;45999;46941;47179.76410117927;47337.05325893394;35620;38442.615573845025;38721.6127838718;39372.409413858244;39497;38073.4288985671;38240.426393603564;38336.42495362627;38526.80736596411;38575.42136868005;34374.31251375008;35603.93188204358;35754.64245357513;35966;36137.457938131476;29700.366479843815;34294.65705343014;34490;34550.82724586462;34695.13262168466;25481.74518254868;25688.357791055372;25844;25916.35209119787;26072.739272607032 01:25:03 INFO - PROCESS | 1676 | |2;jquery.html;362.4364113803035;365.03448379037445;365.0854609203944;372.49712887601726;373.40814808528484;16049.438269660564;19181.520461988457;19792.703109453352;20290.391288261377;21019.47451313716;16174.19129043549;19927.402177934648;19995.500112497193;20009.399718008448;20268.89865550674;4944;5619.353774315945;5696.458836410535;5896.174535565025;5985.072313791369;5818.156367326735;5886.705664716768;5927.170196172539;5938.46553810157;5941.673207973559;4123.9793801030955;5639.379668236491;5879.706014699269;5895.086261629433;6223.097650840626;6389.361063893597;6401.871962560723;6403.295637479897;6439.098526206359;6439.5170362223025;5377.7311134443125;5584.385717571064;5591.6365436246515;5594.524465420403;5635.5773317001385;24207.757922420726;24254.39364015896;24457.633135502983;24482.510349792905;24914.626280605804;2047.7849825768378;2125.0649714125734;2163.697082408464;2169.631162702344;2226.77732226776;9328.533573321374;9803.90196098037;10009.949950250275;10116.443595602239;14988.87583431247;1742.6166243426426;1789.677857985562;1810.9637807243782;1828.168183476515;1846.7414561961336;104592;105077.42383864248;105645;106225.40661890077;111671;11272.492737826817;11372.545098196146;11389.601363952388;11466.54133834654;11472.827907581393;13526.729465410637;13607.047506674438;13622;13648.24934628605;13680.452781888813;7700.845983080307;8045;8468.703595374132;8512.063672995966;8528.445651032664;7389.298016688406;8512.574371281411;8567.828643427221;8625.91374086251;8671.002834673967;4425.933610995838;4427.512973572904;4513.954860451419;4522.253828118323;4555.316702494652;1832.5052235896233;1879.2483006797117;1882.1248119624167;1893.4792931943825;1895.9052047397574;389.8830350894777;395.1918327021248;406.45940898604783;761.5735188294573;946.7207173883721;9691.418514889128;11250;11602.361870097056;11787.705307367385;11913;443.9289713645866;447.28211220990494;454.7862504622888;465.93243979622764;469.1344469453852;5947.851303717442;6102.511799056065;6102.603330783485;6110.511159107261;6135.32511423743;510238;558888;586093;638588;643400;97725;105954.94045059451;120014;121924.39037804754;123208;1022.3661329975463;1047.701405099543;1063.3354153653966;1064.861567996171;1073.1254027967025;18393.81606183921;18498.075096245404;18809;18889;19109.61780764349;49241.50758492369;50580.49419505758;50947.2357914639;51487;53054;55668.49491772961;70620.64689676519;71447.28552714406;71537.64231179019;72352.27647723455;7874.37005039584;7905.802354941173;7988.520688758693;8114.83770324602;8179.345652347917;9925.404475731479;11832.580090389209;12028.338441385458;12526.686832829253;13063.738725225632;10867.782644346911;10885.292455990335;10911.454427278446;11073.280236784583;11137.721556960816;9888.950555247466;10699;10745.355278683304;10766.515506802056;10772.461376931278;10796.63631387763;11114.888851111386;11236.494357753758;11306.547738090385;11317.773644526898;6489.610623362613;8028.759137225892;8085.231902969209;8299.253067223979;8308.5430301334;7143.2499587544635;8361.372897032868;9981.101700846959;10175.694729158136;10380.688579342632 01:25:03 INFO - PROCESS | 1676 | |3;mootools.html;1361.2649169448496;1535.217039309952;1723.8017627972788;1868.3651804670912;1877.1552801239445;7803;8474.940632420947;8742.825143497126;8899.733008009754;8938.508382038985;8602.956985215065;8606.225439710424;8711.215990560848;8746.91253087469;8749.912500874989;2433.2092070077206;2438.4635380216414;2451.901923923041;2453.50929814037;2465.790407815338;2416.930438714613;2483.689538807649;2498.2380373985925;2501.6247562865624;2504.5742223821903;2157.7410710714657;2393.8922748476275;2451.080844683244;2481.4788894332214;2508.234988328559;2426.5268272686835;2458.323960910746;2463.027104293812;2466.728659847415;2470.3206618180056;2376.370261880603;2398.784109430142;2418.818588605844;2420.891059902291;2430.793382562467;8633.266172375355;8677.739667809976;8681.956590217073;8717.7820554486;8751.912480875237;4966.850994470172;5212.40057393397;5386.73066346685;5490.780368785284;5493.148561972901;3583.068402215417;3633.818309084535;3673.3938900081453;3720.5907350191455;3723.0320116769835;1052.3370276725614;1055.166418529361;1077.256692881909;1085.2945585369573;1087.8041952448557;11844.407779610985;11982.580609678707;11995.64013079609;12006.879931200663;12051.939740301243;4075.735077219971;4831.73425461596;4945.530174633404;4957.405111386584;5017.422996355466;10090.949545252373;10175;10196.796064078677;10218.693439196835;10229.539670714836;5416.160495123262;5498.972505137529;5520.944790552043;5552.333719953632;5554.833354999276;5001.374828146481;5010.098182327143;5013.323201367842;5029.622778291643;5067.746612669352;3271.3620843935205;3972.1459886124044;4020.8793736187963;4043.332850079763;4081.428599996003;1309.2013871538354;1325.7812460944028;1326.6152815683536;1340.2092765268537;1352.9526466573623;1018.2057994764095;1109.4230999880017;1135.432283858071;1255.2719422734792;1363.1684672349859;7989.2809647132035;8049.758507244792;8107.55408452529;8123.918760812317;8174.509529428254;1187.4062968515743;1190.0657983483097;1194.4027986006997;1207.6799648093263;1219.116140797932;6074.817755467343;6169.629822210592;6232.532560058014;6243.75024999004;6255.74977000924;10344.810346810063;10542.683719488428;10675.83986240207;10701.411422371688;10784.838227426595;9289.792326997447;10452.947735261276;10516.789664206673;10598.20513461478;10598.576056957789;6718.328167183243;8267;8395.454295470774;8408;8420;7628.656710447932;7999.360051196007;8011.759647210593;8028.558429286445;8215.383846211678;9456.196223321094;9530.856297244098;9622.13400793932;9691.321607487409;9812.901870981485;9509.762255943657;9719;9789.412635241908;10046.849297260693;10087.848682269918;6060.969695151496;7484;7520.398368130646;7560.5841678706;7568.735094271674;8027.1972802719265;8078.071021832329;8088.433809633505;8143.51138931666;8144.981877265342;6731.865362692621;7233.674484648098;7407.92592074094;7444.516106453063;7511.32398084175;7221.169565500035;7349.595772232578;7367.4106071515225;7376.373008294355;7448.031755871702;7702.730404435818;7770.844583108419;7791.727289544839;7792.922070779219;7839.176886426843;6956;7053.6825842838225;7094.290570942864;7099.432045436456;7102.786916392516;7052.612106333996;7141.9642901785155;7165.964170179324;7186.173590037003;7198.5320954137815 01:25:03 INFO - PROCESS | 1676 | |4;prototype.html;276.30371463910933;323.2694111308443;328.566292493908;332.49626815374705;336.39952684458245;5301.6818990860575;6644.700988455519;6805.591664500121;6882.965585172074;6911.412529934962;6678.198616166054;6801.591904485735;6803.591784492934;6839.247682754893;6869.519133660646;4985.476524964881;4987.326710894019;4994;5001.049800537886;5007.724575148365;4989.077020751154;4997.975010124945;5009.998000399916;5022.472640372763;5026.070177017245;4956.578690811268;4964;4964.205727083668;4965.180745177059;4979.825706100287;4059.451973983504;4677;4850.175470170045;4906.969536397343;4984.32711583937;4048.1903619276263;4088.5093788745244;4092;4110.362893751473;4118.320477121271;6399.296077431479;6428.839279018062;6447;6458.547901646886;6467.288598254188;4608.516105808875;5573.665580065209;5744.540436765049;5771.336296325934;5777.826665200051;7125.679344429514;7133.8216544586285;7142.607156606385;7146.928530714678;7151.570905745672;4129.988152902528;4228.386883901848;4592.2422800238255;4599.586037256663;4622.14490319292;6906.791311520464;7567;7673.237634451593;7691.961540192263;7692.884606730903;4183.895402614959;4462.709923854939;4547.636189104864;4579.9542004579525;4670.883227919261;4740.360051393018;4744.739039352799;4751.311059896296;4765.642576806753;4766;5709.714514274269;5711.7144142792695;5722.62802917809;5729.9713501432225;5730.426957304237;5857.824265272048;7123.430125590044;7268.745593904294;7274.418046556263;7350.816229594196;1256.1897576063388;1557.844215578433;1610.5570967983663;1626.9267882945296;1663.6173680053655;1040.9850395864123;1044.3577200022085;1051.7633532455136;1055.4775386183887;1059.5549869055014;6090.63456192621;6155.645757933247;6710.530262881649;6736.5958042517605;6737.292584278678;5748.425157484218;7110.8978108393285;7435.814104647319;7472.29013243741;7510.436717246228;6694.531382803157;6736.427403670743;6741.561798483083;6761.425278851254;6764.526483146133;3929;3941.3890846918775;3960.029792700749;3976.224636195972;3985.980070099631;6985.637800628829;7169.928300717031;7178.712851485987;7803.531788092732;7852.803679908048;7742.806429839299;7751.573663448565;7751.651175696994;7769.72805951789;7873.527588344603;7870.9606451967375;7900.881486777588;7912.169222231582;7914.169012253861;7914.406419518559;6025.578209525466;6860.456397310565;6878.793636190922;7588.696452141852;7599.392048635986;7214.567125972459;7398.408127349691;7435.367993720594;7449.020391843306;7463.552186868806;6598.769043083469;7877.369810415267;7917.2874441300555;7926.167752385916;7949;4697.976510117427;4703.905921881612;4705.976470117627;4707.411573553306;4758.738269395217;7250.9637451812405;7495.850082998419;7518.060242469692;7527.247275272648;7538.962305188439;6182.412670796267;6999.930000699927;7223.602701851239;7267.563946163247;7323.9267607323245;5889;7272;7289.963550182215;7291.161516425467;7306.452016098708;7103.076600041962;7110.928890711027;7120.821979450555;7124.964375178091;7139.071920650283;7059.258777828254;7263.455240856852;7295.635218239173;7297.087864016998;7301.379382752525;5882.23530940975;6961.060256865258;7062.293770622897;7063.25835787235;7076.398506127037 01:25:03 INFO - PROCESS | 1676 | |5;yui.html;650.0208403628209;707.2821086597102;727.2291371146586;738.0000099864683;738.4941315199093;11311.886881131186;14551.126932384064;14666.706665866675;14673.192974386404;14732;13286.870615997652;13352.198868067899;13406.530771423002;13440.93279533601;13485.797713034312;702.388921638173;849.1041950741949;850.421713235;870.3472395703222;883.4964070479829;862.6678728689468;868.3921255121409;869.656485688156;870.3776799588293;875.8204568063563;908.1100521488945;919.9172074513292;923.5474617437475;923.9538023098818;925.9120383563584;898.4160295807744;900.8603666431713;910.3900386740834;916.1067958740242;917.8118485710413;660.4089340040637;672.1228796420669;685.7702669605688;686.084077756196;686.5708931917552;14157.575272741835;14415.855841441557;14520.056196347203;14530.782038269434;14629.707405851823;12635.810462843065;12686.619401417973;12748.872511274862;12788.552400665933;13033.283169425678;8525.50105182154;10426.061654451136;10794.622188223375;10963.780724385548;11551.53793848245;3472.861085556575;3478.2000139967695;3508.2281897982402;3512.947305790415;3518.36669399508;83787.16212837855;83916.16083839144;84066;85334.71997920037;86943.13056869413;9187.862182067274;9382.953085234667;9400.341976061747;9446.669366572138;9649.951750241204;20425.591488170154;20528.486787830127;20648.070836812378;20677.379678609665;20729.170833166503;7212.098487689039;7423.480356375002;7434.7769566913075;7580.772576822704;7705.460617756703;3966.8809935701975;3998.1204135090234;4020.638142567183;4036.535798383165;4041.9797901010306;3425.811580363054;3453.9654603453646;3469.098034511045;3472.2361080562237;3473.565804274466;625.3683779382765;635.5741653092439;635.845939619589;656.9146011018537;659.2846761264083;560.1737437280061;587.8030859662061;596.6420147911218;614.1923370767427;616.8673735146965;8352.331813454908;8487.36344774132;8502.532360720095;8662.566871656392;8701.912980870236;499.6777078784164;527.3750605532456;578.1472328315784;610.9358517355703;659.8086554899121;3815.6184381562175;3967.821448034845;4072.898177545585;4298.505671847715;4335.653147748172;89329;89508;89989;90447;91107.54446227726;75522.62238688882;77733.6113319441;78052.2194778045;82137.58931205305;82569.58715206505;65569.01646475306;66440.66779666167;66504;67054.99417508741;67740;7404.777856664308;8587.441816281922;8836.160564746338;8912.955435222782;8945.507997059964;44376;45081.32378014398;45344;45638.54361456343;46026.84932876705;59800.40199597948;60355;60573.39426605678;60913.402144024156;61152.471188220654;10758.354498730101;10888.61889833852;10897.073748731447;10995.945020274847;11279.32324060559;11841.28952262867;11956.402179890796;12102.092343074128;12329.815052774036;12368.690782730504;10031.29780915329;10796.460176991277;10845.511951962022;11572.735671922073;11740.29558226475;9257.259419246579;10559.208059395729;10777.13782897382;11172.776544469227;11881.405929703653;10928.781424371628;11253.099752019654;11431.942840285745;11544.711382215512;11918.344491053076;9247.537623118951;9382.967873534042;9479.857802132836;9757.170640495637;10206.642767503101;7969.960150199444;8639.352048596505;9155.404898681565;9200.723978280663;9907.108360247612 01:25:03 INFO - PROCESS | 1676 | __end_tp_report 01:25:03 INFO - PROCESS | 1676 | __start_cc_report 01:25:03 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,339 01:25:03 INFO - PROCESS | 1676 | __end_cc_report 01:25:03 INFO - PROCESS | 1676 | __startTimestamp1456392303593__endTimestamp 01:25:03 INFO - PROCESS | 1676 | 01:25:03 INFO - PROCESS | 1676 | ------- Summary: start ------- 01:25:03 INFO - PROCESS | 1676 | Number of tests: 6 01:25:03 INFO - PROCESS | 1676 | 01:25:03 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5638.41 Median:5925.14 stddev:797.02 (13.5%) stddev-sans-first:779.58 01:25:03 INFO - PROCESS | 1676 | Values: 3383.1 3515.9 3547.0 3569.4 3609.5 4187.8 5644.1 5729.8 5736.1 5754.1 4735.8 5583.6 5718.1 5720.4 5761.0 5123.9 5211.4 5217.4 5248.2 5295.8 536.8 5126.1 5189.8 5200.1 5221.2 4639.0 4787.4 4998.7 5216.9 5274.2 4735.1 5261.3 5286.7 5306.2 5307.7 5161.7 5184.9 5191.9 5245.3 5269.1 4459.9 4635.7 5579.2 5598.9 5650.2 6119.8 6182.7 6212.1 6229.2 6237.5 6218.5 6227.6 6236.9 6238.1 6241.6 5867.0 5871.8 5888.9 5903.2 5927.1 4611.6 6182.7 6219.9 6267.3 6356.7 5548.0 5818.3 6156.8 6166.3 6191.9 6176.8 6225.8 6240.3 6240.6 6247.0 5108.5 6106.0 6145.0 6158.9 6212.7 6169.0 6170.7 6187.8 6219.7 6223.6 3950.0 4792.4 4857.4 4893.0 4963.6 4263.0 4338.9 4381.4 4386.8 4448.8 4571.3 5620.8 5792.3 5854.4 5896.6 6136.2 6211.6 6239.8 6246.2 6251.5 5817.0 5870.6 5925.1 5931.7 6004.4 5331.3 5367.9 5391.1 5400.6 5412.0 6172.4 6313.5 6408.7 6412.9 6428.5 5164.9 6227.4 6229.4 6230.2 6248.2 6322.9 6394.6 6395.8 6398.3 6427.8 6096.9 6136.2 6229.1 6231.4 6234.4 6205.5 6216.6 6224.1 6236.7 6239.5 5794.9 6101.1 6161.9 6174.1 6182.2 5131.6 6141.1 6159.4 6161.6 6164.6 5257.9 5978.0 6029.4 6046.3 6061.2 5449.6 6016.6 6123.0 6204.3 6212.4 5171.8 5859.3 5938.9 6017.2 6115.8 01:25:03 INFO - PROCESS | 1676 | 01:25:03 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:64389.38 Median:39375.01 stddev:134873.91 (342.5%) stddev-sans-first:135166.84 01:25:03 INFO - PROCESS | 1676 | Values: 454.1 468.8 478.6 511.9 535.6 37460.4 37766.6 37778.0 37826.6 37925.0 38695.6 39312.2 39377.6 39423.4 39450.4 9315.5 9450.5 9467.3 9520.6 9551.9 9438.4 9645.2 9695.7 9711.5 9719.9 9702.0 9721.3 9723.6 9799.8 9802.7 9694.1 9725.4 9768.5 9773.2 9778.6 9554.3 9614.7 9682.3 9702.2 9739.7 38369.4 38465.6 38762.0 38765.0 38990.8 2721.8 2735.8 3433.0 3750.3 3837.0 21675.6 26965.9 27850.4 27865.3 28353.7 2793.9 2842.0 2856.9 2865.9 2909.9 508635.0 510768.0 513131.4 514292.0 515382.0 44586.6 45083.0 67991.0 68417.0 68486.7 46024.0 46027.8 46213.8 46552.8 46635.8 15344.1 15431.2 15661.4 15819.4 15836.3 12315.4 12318.3 12528.5 12536.9 12575.6 14610.7 14625.2 14698.9 14790.8 14865.0 6182.9 6309.9 6329.2 6330.2 6337.5 916.6 935.7 948.3 982.6 1016.6 22561.3 25496.9 29504.7 29713.3 30072.0 974.6 1059.9 1069.9 1071.5 1095.8 13548.9 14336.5 14375.1 14429.6 14658.8 509976.0 519934.0 520671.0 521147.0 521258.0 45223.8 50991.0 59690.4 59995.1 61240.7 1244.2 1355.6 1384.4 1405.1 1441.5 23506.0 30946.4 30969.0 31215.0 31658.5 46233.5 56123.0 56474.7 56639.2 57295.1 480352.0 485789.0 489235.0 493353.0 494467.0 41779.8 44120.6 44694.8 44906.0 45062.9 44859.6 45999.0 46941.0 47179.8 47337.1 35620.0 38442.6 38721.6 39372.4 39497.0 38073.4 38240.4 38336.4 38526.8 38575.4 34374.3 35603.9 35754.6 35966.0 36137.5 29700.4 34294.7 34490.0 34550.8 34695.1 25481.7 25688.4 25844.0 25916.4 26072.7 01:25:03 INFO - PROCESS | 1676 | 01:25:03 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:33062.40 Median:381.65 stddev:97930.32 (25660.0%) stddev-sans-first:98174.26 01:25:03 INFO - PROCESS | 1676 | Values: 362.4 365.0 365.1 372.5 373.4 16049.4 19181.5 19792.7 20290.4 21019.5 16174.2 19927.4 19995.5 20009.4 20268.9 4944.0 5619.4 5696.5 5896.2 5985.1 5818.2 5886.7 5927.2 5938.5 5941.7 4124.0 5639.4 5879.7 5895.1 6223.1 6389.4 6401.9 6403.3 6439.1 6439.5 5377.7 5584.4 5591.6 5594.5 5635.6 24207.8 24254.4 24457.6 24482.5 24914.6 2047.8 2125.1 2163.7 2169.6 2226.8 9328.5 9803.9 10009.9 10116.4 14988.9 1742.6 1789.7 1811.0 1828.2 1846.7 104592.0 105077.4 105645.0 106225.4 111671.0 11272.5 11372.5 11389.6 11466.5 11472.8 13526.7 13607.0 13622.0 13648.2 13680.5 7700.8 8045.0 8468.7 8512.1 8528.4 7389.3 8512.6 8567.8 8625.9 8671.0 4425.9 4427.5 4514.0 4522.3 4555.3 1832.5 1879.2 1882.1 1893.5 1895.9 389.9 395.2 406.5 761.6 946.7 9691.4 11250.0 11602.4 11787.7 11913.0 443.9 447.3 454.8 465.9 469.1 5947.9 6102.5 6102.6 6110.5 6135.3 510238.0 558888.0 586093.0 638588.0 643400.0 97725.0 105954.9 120014.0 121924.4 123208.0 1022.4 1047.7 1063.3 1064.9 1073.1 18393.8 18498.1 18809.0 18889.0 19109.6 49241.5 50580.5 50947.2 51487.0 53054.0 55668.5 70620.6 71447.3 71537.6 72352.3 7874.4 7905.8 7988.5 8114.8 8179.3 9925.4 11832.6 12028.3 12526.7 13063.7 10867.8 10885.3 10911.5 11073.3 11137.7 9889.0 10699.0 10745.4 10766.5 10772.5 10796.6 11114.9 11236.5 11306.5 11317.8 6489.6 8028.8 8085.2 8299.3 8308.5 7143.2 8361.4 9981.1 10175.7 10380.7 01:25:03 INFO - PROCESS | 1676 | 01:25:03 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:6041.84 Median:5048.68 stddev:3164.88 (62.7%) stddev-sans-first:3154.20 01:25:03 INFO - PROCESS | 1676 | Values: 1361.3 1535.2 1723.8 1868.4 1877.2 7803.0 8474.9 8742.8 8899.7 8938.5 8603.0 8606.2 8711.2 8746.9 8749.9 2433.2 2438.5 2451.9 2453.5 2465.8 2416.9 2483.7 2498.2 2501.6 2504.6 2157.7 2393.9 2451.1 2481.5 2508.2 2426.5 2458.3 2463.0 2466.7 2470.3 2376.4 2398.8 2418.8 2420.9 2430.8 8633.3 8677.7 8682.0 8717.8 8751.9 4966.9 5212.4 5386.7 5490.8 5493.1 3583.1 3633.8 3673.4 3720.6 3723.0 1052.3 1055.2 1077.3 1085.3 1087.8 11844.4 11982.6 11995.6 12006.9 12051.9 4075.7 4831.7 4945.5 4957.4 5017.4 10090.9 10175.0 10196.8 10218.7 10229.5 5416.2 5499.0 5520.9 5552.3 5554.8 5001.4 5010.1 5013.3 5029.6 5067.7 3271.4 3972.1 4020.9 4043.3 4081.4 1309.2 1325.8 1326.6 1340.2 1353.0 1018.2 1109.4 1135.4 1255.3 1363.2 7989.3 8049.8 8107.6 8123.9 8174.5 1187.4 1190.1 1194.4 1207.7 1219.1 6074.8 6169.6 6232.5 6243.8 6255.7 10344.8 10542.7 10675.8 10701.4 10784.8 9289.8 10452.9 10516.8 10598.2 10598.6 6718.3 8267.0 8395.5 8408.0 8420.0 7628.7 7999.4 8011.8 8028.6 8215.4 9456.2 9530.9 9622.1 9691.3 9812.9 9509.8 9719.0 9789.4 10046.8 10087.8 6061.0 7484.0 7520.4 7560.6 7568.7 8027.2 8078.1 8088.4 8143.5 8145.0 6731.9 7233.7 7407.9 7444.5 7511.3 7221.2 7349.6 7367.4 7376.4 7448.0 7702.7 7770.8 7791.7 7792.9 7839.2 6956.0 7053.7 7094.3 7099.4 7102.8 7052.6 7142.0 7166.0 7186.2 7198.5 01:25:03 INFO - PROCESS | 1676 | 01:25:03 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:5823.61 Median:6661.45 stddev:1898.96 (28.5%) stddev-sans-first:1858.08 01:25:03 INFO - PROCESS | 1676 | Values: 276.3 323.3 328.6 332.5 336.4 5301.7 6644.7 6805.6 6883.0 6911.4 6678.2 6801.6 6803.6 6839.2 6869.5 4985.5 4987.3 4994.0 5001.0 5007.7 4989.1 4998.0 5010.0 5022.5 5026.1 4956.6 4964.0 4964.2 4965.2 4979.8 4059.5 4677.0 4850.2 4907.0 4984.3 4048.2 4088.5 4092.0 4110.4 4118.3 6399.3 6428.8 6447.0 6458.5 6467.3 4608.5 5573.7 5744.5 5771.3 5777.8 7125.7 7133.8 7142.6 7146.9 7151.6 4130.0 4228.4 4592.2 4599.6 4622.1 6906.8 7567.0 7673.2 7692.0 7692.9 4183.9 4462.7 4547.6 4580.0 4670.9 4740.4 4744.7 4751.3 4765.6 4766.0 5709.7 5711.7 5722.6 5730.0 5730.4 5857.8 7123.4 7268.7 7274.4 7350.8 1256.2 1557.8 1610.6 1626.9 1663.6 1041.0 1044.4 1051.8 1055.5 1059.6 6090.6 6155.6 6710.5 6736.6 6737.3 5748.4 7110.9 7435.8 7472.3 7510.4 6694.5 6736.4 6741.6 6761.4 6764.5 3929.0 3941.4 3960.0 3976.2 3986.0 6985.6 7169.9 7178.7 7803.5 7852.8 7742.8 7751.6 7751.7 7769.7 7873.5 7871.0 7900.9 7912.2 7914.2 7914.4 6025.6 6860.5 6878.8 7588.7 7599.4 7214.6 7398.4 7435.4 7449.0 7463.6 6598.8 7877.4 7917.3 7926.2 7949.0 4698.0 4703.9 4706.0 4707.4 4758.7 7251.0 7495.9 7518.1 7527.2 7539.0 6182.4 6999.9 7223.6 7267.6 7323.9 5889.0 7272.0 7290.0 7291.2 7306.5 7103.1 7110.9 7120.8 7125.0 7139.1 7059.3 7263.5 7295.6 7297.1 7301.4 5882.2 6961.1 7062.3 7063.3 7076.4 01:25:03 INFO - PROCESS | 1676 | 01:25:03 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:17856.86 Median:30883.33 stddev:25191.04 (81.6%) stddev-sans-first:25228.57 01:25:03 INFO - PROCESS | 1676 | Values: 650.0 707.3 727.2 738.0 738.5 11311.9 14551.1 14666.7 14673.2 14732.0 13286.9 13352.2 13406.5 13440.9 13485.8 702.4 849.1 850.4 870.3 883.5 862.7 868.4 869.7 870.4 875.8 908.1 919.9 923.5 924.0 925.9 898.4 900.9 910.4 916.1 917.8 660.4 672.1 685.8 686.1 686.6 14157.6 14415.9 14520.1 14530.8 14629.7 12635.8 12686.6 12748.9 12788.6 13033.3 8525.5 10426.1 10794.6 10963.8 11551.5 3472.9 3478.2 3508.2 3512.9 3518.4 83787.2 83916.2 84066.0 85334.7 86943.1 9187.9 9383.0 9400.3 9446.7 9650.0 20425.6 20528.5 20648.1 20677.4 20729.2 7212.1 7423.5 7434.8 7580.8 7705.5 3966.9 3998.1 4020.6 4036.5 4042.0 3425.8 3454.0 3469.1 3472.2 3473.6 625.4 635.6 635.8 656.9 659.3 560.2 587.8 596.6 614.2 616.9 8352.3 8487.4 8502.5 8662.6 8701.9 499.7 527.4 578.1 610.9 659.8 3815.6 3967.8 4072.9 4298.5 4335.7 89329.0 89508.0 89989.0 90447.0 91107.5 75522.6 77733.6 78052.2 82137.6 82569.6 65569.0 66440.7 66504.0 67055.0 67740.0 7404.8 8587.4 8836.2 8913.0 8945.5 44376.0 45081.3 45344.0 45638.5 46026.8 59800.4 60355.0 60573.4 60913.4 61152.5 10758.4 10888.6 10897.1 10995.9 11279.3 11841.3 11956.4 12102.1 12329.8 12368.7 10031.3 10796.5 10845.5 11572.7 11740.3 9257.3 10559.2 10777.1 11172.8 11881.4 10928.8 11253.1 11431.9 11544.7 11918.3 9247.5 9383.0 9479.9 9757.2 10206.6 7970.0 8639.4 9155.4 9200.7 9907.1 01:25:03 INFO - PROCESS | 1676 | -------- Summary: end -------- 01:25:03 INFO - PROCESS | 1676 | 01:25:04 INFO - TEST-INFO | 1676: exit 0 01:25:04 INFO - TEST-OK | dromaeo_css | took 1109919ms 01:25:04 INFO - TEST-START | kraken 01:25:04 INFO - operating with platform_type : mac_ 01:25:04 INFO - Initialising browser for kraken test... 01:25:04 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpYKp1y7/profile http://localhost:49283/getInfo.html) 01:25:07 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 01:25:07 INFO - PROCESS | 1683 | colorDepth:24 01:25:07 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 01:25:07 INFO - PROCESS | 1683 | __metrics 01:25:07 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:25:07 INFO - TEST-INFO | 1683: exit 0 01:25:07 INFO - Browser initialized. 01:25:07 INFO - Running cycle 1/1 for kraken test... 01:25:07 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpYKp1y7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:25:19 INFO - PROCESS | 1686 | RSS: Main: 256188416 01:25:19 INFO - PROCESS | 1686 | 01:25:22 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 01:25:23 INFO - PROCESS | 1686 | RSS: Main: 269115392 01:25:23 INFO - PROCESS | 1686 | 01:25:25 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 01:25:26 INFO - PROCESS | 1686 | RSS: Main: 276623360 01:25:26 INFO - PROCESS | 1686 | 01:25:29 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 01:25:30 INFO - PROCESS | 1686 | RSS: Main: 280936448 01:25:30 INFO - PROCESS | 1686 | 01:25:32 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 01:25:32 INFO - PROCESS | 1686 | RSS: Main: 282349568 01:25:32 INFO - PROCESS | 1686 | 01:25:34 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:25:35 INFO - PROCESS | 1686 | RSS: Main: 284286976 01:25:35 INFO - PROCESS | 1686 | 01:25:38 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 01:25:39 INFO - PROCESS | 1686 | RSS: Main: 283848704 01:25:39 INFO - PROCESS | 1686 | 01:25:42 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 01:25:42 INFO - PROCESS | 1686 | RSS: Main: 283566080 01:25:42 INFO - PROCESS | 1686 | 01:25:45 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 01:25:46 INFO - PROCESS | 1686 | RSS: Main: 284037120 01:25:46 INFO - PROCESS | 1686 | 01:25:47 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:25:48 INFO - PROCESS | 1686 | RSS: Main: 284020736 01:25:48 INFO - PROCESS | 1686 | 01:25:50 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:25:50 INFO - PROCESS | 1686 | RSS: Main: 282836992 01:25:50 INFO - PROCESS | 1686 | 01:25:52 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:25:53 INFO - PROCESS | 1686 | RSS: Main: 284852224 01:25:53 INFO - PROCESS | 1686 | 01:25:56 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:25:56 INFO - PROCESS | 1686 | RSS: Main: 284499968 01:25:56 INFO - PROCESS | 1686 | 01:25:59 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:26:00 INFO - PROCESS | 1686 | RSS: Main: 284950528 01:26:00 INFO - PROCESS | 1686 | 01:26:01 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 01:26:02 INFO - PROCESS | 1686 | RSS: Main: 284549120 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | __start_tp_report 01:26:02 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 01:26:02 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 01:26:02 INFO - PROCESS | 1686 | |i|pagename|runs| 01:26:02 INFO - PROCESS | 1686 | |0;ai-astar;111;150;98;135;167;184;114;115;114;115 01:26:02 INFO - PROCESS | 1686 | |1;audio-beat-detection;155;125;142;162;157;141;140;133;178;148 01:26:02 INFO - PROCESS | 1686 | |2;audio-dft;199;192;197;229;270;210;198;194;197;196 01:26:02 INFO - PROCESS | 1686 | |3;audio-fft;72;70;72;105;59;55;59;59;115;57 01:26:02 INFO - PROCESS | 1686 | |4;audio-oscillator;87;81;124;94;121;122;138;82;82;114 01:26:02 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;107;120;131;118;88;142;86;92;108;120 01:26:02 INFO - PROCESS | 1686 | |6;imaging-darkroom;94;99;140;151;117;95;97;95;95;96 01:26:02 INFO - PROCESS | 1686 | |7;imaging-desaturate;77;154;152;99;92;90;91;90;91;92 01:26:02 INFO - PROCESS | 1686 | |8;json-parse-financial;57;56;56;55;56;56;56;64;55;54 01:26:02 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;65;67;69;79;92;101;65;69;83;100 01:26:02 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;85;84;86;84;90;84;85;88;86;84 01:26:02 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;151;143;143;122;138;130;134;116;124;134 01:26:02 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;130;143;154;156;135;183;183;160;170;174 01:26:02 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;60;96;60;85;69;67;82;98;99;93 01:26:02 INFO - PROCESS | 1686 | __end_tp_report 01:26:02 INFO - PROCESS | 1686 | __start_cc_report 01:26:02 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,908 01:26:02 INFO - PROCESS | 1686 | __end_cc_report 01:26:02 INFO - PROCESS | 1686 | __startTimestamp1456392362196__endTimestamp 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | ------- Summary: start ------- 01:26:02 INFO - PROCESS | 1686 | Number of tests: 14 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:130.30 Median:142.50 stddev:28.00 (19.6%) stddev-sans-first:28.81 01:26:02 INFO - PROCESS | 1686 | Values: 111.0 150.0 98.0 135.0 167.0 184.0 114.0 115.0 114.0 115.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:151.50 stddev:15.38 (10.2%) stddev-sans-first:16.11 01:26:02 INFO - PROCESS | 1686 | Values: 155.0 125.0 142.0 162.0 157.0 141.0 140.0 133.0 178.0 148.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:208.20 Median:198.50 stddev:24.28 (12.2%) stddev-sans-first:25.53 01:26:02 INFO - PROCESS | 1686 | Values: 199.0 192.0 197.0 229.0 270.0 210.0 198.0 194.0 197.0 196.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:72.30 Median:59.00 stddev:20.98 (35.6%) stddev-sans-first:22.25 01:26:02 INFO - PROCESS | 1686 | Values: 72.0 70.0 72.0 105.0 59.0 55.0 59.0 59.0 115.0 57.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:81.50 stddev:21.48 (26.4%) stddev-sans-first:21.83 01:26:02 INFO - PROCESS | 1686 | Values: 87.0 81.0 124.0 94.0 121.0 122.0 138.0 82.0 82.0 114.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:111.20 Median:136.50 stddev:18.59 (13.6%) stddev-sans-first:19.66 01:26:02 INFO - PROCESS | 1686 | Values: 107.0 120.0 131.0 118.0 88.0 142.0 86.0 92.0 108.0 120.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:107.90 Median:95.00 stddev:21.09 (22.2%) stddev-sans-first:21.76 01:26:02 INFO - PROCESS | 1686 | Values: 94.0 99.0 140.0 151.0 117.0 95.0 97.0 95.0 95.0 96.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:102.80 Median:91.00 stddev:27.00 (29.7%) stddev-sans-first:26.98 01:26:02 INFO - PROCESS | 1686 | Values: 77.0 154.0 152.0 99.0 92.0 90.0 91.0 90.0 91.0 92.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:2.76 (4.9%) stddev-sans-first:2.92 01:26:02 INFO - PROCESS | 1686 | Values: 57.0 56.0 56.0 55.0 56.0 56.0 56.0 64.0 55.0 54.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:79.00 Median:69.00 stddev:14.32 (20.8%) stddev-sans-first:14.27 01:26:02 INFO - PROCESS | 1686 | Values: 65.0 67.0 69.0 79.0 92.0 101.0 65.0 69.0 83.0 100.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.50 stddev:2.01 (2.4%) stddev-sans-first:2.12 01:26:02 INFO - PROCESS | 1686 | Values: 85.0 84.0 86.0 84.0 90.0 84.0 85.0 88.0 86.0 84.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:136.00 stddev:10.79 (7.9%) stddev-sans-first:9.41 01:26:02 INFO - PROCESS | 1686 | Values: 151.0 143.0 143.0 122.0 138.0 130.0 134.0 116.0 124.0 134.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:165.00 stddev:18.87 (11.4%) stddev-sans-first:16.90 01:26:02 INFO - PROCESS | 1686 | Values: 130.0 143.0 154.0 156.0 135.0 183.0 183.0 160.0 170.0 174.0 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.90 Median:89.00 stddev:15.71 (17.7%) stddev-sans-first:14.73 01:26:02 INFO - PROCESS | 1686 | Values: 60.0 96.0 60.0 85.0 69.0 67.0 82.0 98.0 99.0 93.0 01:26:02 INFO - PROCESS | 1686 | -------- Summary: end -------- 01:26:02 INFO - PROCESS | 1686 | 01:26:02 INFO - TEST-INFO | 1686: exit 0 01:26:02 INFO - TEST-OK | kraken | took 58833ms 01:26:02 INFO - SUITE-END | took 1168s 01:26:03 INFO - Completed test suite (00:19:29) 01:26:03 INFO - Working with test: dromaeo_css 01:26:03 INFO - Generating results file: dromaeo_css 01:26:03 INFO - Working with test: kraken 01:26:03 INFO - Generating results file: kraken 01:26:03 INFO - javascript benchmark 01:26:03 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:26:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 01:26:03 INFO - process_Request line: dromaeo_css 7386.48 graph.html#tests=[[72,64,61]] 01:26:03 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:26:03 INFO - process_Request line: kraken 1579.60 graph.html#tests=[[232,64,61]] 01:26:03 INFO - RETURN: dromaeo_css: 7386.48 01:26:03 INFO - RETURN: kraken: 1579.60 01:26:03 INFO - javascript benchmark 01:26:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3383.1372999885034, 3515.859365625375, 3546.9822650886726, 3569.411047177216, 3609.5488063992, 4187.769672668002, 5644.096944488882, 5729.770809167629, 5736.110902810061, 5754.136879468082, 4735.763211839411, 5583.58123140764, 5718.1136923776885, 5720.399358067405, 5761.0, 5123.948760512394, 5211.400688920766, 5217.399999000126, 5248.160294352904, 5295.841124766263, 536.7516846067741, 5126.102931986888, 5189.766460509267, 5200.141976573861, 5221.164613661815, 4638.953610463903, 4787.4494433139935, 4998.675086119409, 5216.921746173792, 5274.182501712241, 4735.124002059595, 5261.316028916254, 5286.735663216824, 5306.151015837486, 5307.708076055854, 5161.690298582097, 5184.922226166611, 5191.948080519184, 5245.318108645852, 5269.077911365534, 4459.866204013885, 4635.7020034390425, 5579.191017302509, 5598.944010559883, 5650.152477128422, 6119.827461251236, 6182.69086545671, 6212.099245609406, 6229.159063526411, 6237.532185086136, 6218.4714299284615, 6227.595206311576, 6236.875262494725, 6238.1266622672865, 6241.563090583661, 5867.0, 5871.823845284605, 5888.852778680524, 5903.203067585907, 5927.110933360031, 4611.5619016193405, 6182.721777519932, 6219.937800622027, 6267.2792628848265, 6356.713947872265, 5547.97362487933, 5818.330891947396, 6156.846078847975, 6166.290876549254, 6191.938080619227, 6176.752929882754, 6225.844353891189, 6240.251169859555, 6240.625562466266, 6247.0, 5108.463611320758, 6106.0, 6145.0, 6158.938410615837, 6212.689365531705, 6168.9691551541955, 6170.7223174957235, 6187.81436556904, 6219.657918814509, 6223.595466294767, 3950.012496875781, 4792.376990991149, 4857.4171099467585, 4892.975535122301, 4963.5780958618925, 4263.0, 4338.934915976263, 4381.408509851193, 4386.780660966939, 4448.822047118079, 4571.314302854598, 5620.831375058755, 5792.333881603585, 5854.414558544197, 5896.557758168155, 6136.243373036893, 6211.627302361872, 6239.812805615838, 6246.187995560548, 6251.499880009588, 5817.0, 5870.647761134345, 5925.140854576149, 5931.703414829241, 6004.369541198199, 5331.253624492574, 5367.919481207785, 5391.137418013178, 5400.567954563626, 5411.972940135274, 6172.4136207060255, 6313.526485513697, 6408.679566021773, 6412.935870641327, 6428.453581445629, 5164.948350516597, 6227.408396202353, 6229.408206220402, 6230.221222347207, 6248.156498872594, 6322.905156422566, 6394.648294343856, 6395.808125756234, 6398.328175541501, 6427.839304017437, 6096.908546371897, 6136.21274067861, 6229.096780966644, 6231.376862313732, 6234.438900498977, 6205.472534834409, 6216.564840461305, 6224.128621992834, 6236.688165591793, 6239.469645080219, 5794.855128621818, 6101.065651476929, 6161.907571386522, 6174.073888916699, 6182.196314479089, 5131.589472842238, 6141.087130295835, 6159.384061593805, 6161.5686901918225, 6164.599301045418, 5257.8695580450385, 5977.970110149421, 6029.397060293935, 6046.334903160737, 6061.181740464981, 5449.64577302474, 6016.63900165974, 6122.989706698345, 6204.348543403058, 6212.409821066992, 5171.836336824184, 5859.267591551056, 5938.851528711817, 6017.157597936205, 6115.847103822262], "unit": "score", "name": "dojo.html", "value": 5593.242623378512}, {"lowerIsBetter": false, "replicates": [454.0804870137968, 468.8171613070903, 478.56928764112314, 511.9377292118853, 535.5581645142757, 37460.43809342859, 37766.62233377666, 37778.0, 37826.62173378269, 37925.0, 38695.613043869555, 39312.21375572487, 39377.60622393775, 39423.408648870216, 39450.408243876365, 9315.534223288842, 9450.4802235877, 9467.2899532535, 9520.571574279174, 9551.90448095517, 9438.386504877195, 9645.228381729445, 9695.70912872615, 9711.465869377182, 9719.902800972006, 9702.0, 9721.270904682176, 9723.611055557805, 9799.804003919953, 9802.656907008257, 9694.127528522431, 9725.41647501145, 9768.462734549597, 9773.21814254858, 9778.55996480153, 9554.283428742803, 9614.663486778, 9682.322237443383, 9702.205092057991, 9739.659111931049, 38369.42445863314, 38465.61534384648, 38762.0, 38765.0, 38990.80504597487, 2721.7550420462057, 2735.7811375089946, 3433.0, 3750.3436898542645, 3837.0407398150464, 21675.566488670138, 26965.865170674217, 27850.442991140266, 27865.303367415774, 28353.71646283552, 2793.9301517462022, 2842.0337085391066, 2856.9000084997133, 2865.885364585435, 2909.86905589249, 508635.0, 510768.0, 513131.4343428259, 514291.9999999963, 515382.0, 44586.55413445824, 45083.0, 67991.0, 68416.97374539386, 68486.65756671184, 46024.0, 46027.76986115048, 46213.76893115513, 46552.83617909512, 46635.76682116568, 15344.079355238498, 15431.151286679116, 15661.373545058297, 15819.446319378996, 15836.28736706851, 12315.4458049388, 12318.260904345769, 12528.498860045678, 12536.934360579453, 12575.622731318075, 14610.707785844224, 14625.195614241105, 14698.926505367404, 14790.778138327934, 14865.0, 6182.938170618326, 6309.873802523924, 6329.240491141, 6330.240371155399, 6337.4613157882095, 916.6287653500343, 935.6584846530967, 948.2698322291934, 982.6216906491053, 1016.6238491758097, 22561.323160305215, 25496.872515637675, 29504.704952950626, 29713.25716857096, 30072.0, 974.6004138303261, 1059.9152067834555, 1069.8609180806445, 1071.50175168547, 1095.7644106517137, 13548.864511354957, 14336.498222562368, 14375.065620734827, 14429.567112986628, 14658.78011829802, 509976.0, 519934.0, 520671.0, 521147.0, 521258.0, 45223.773881130386, 50991.0, 59690.40309596848, 59995.100073498936, 61240.69379653073, 1244.2472304255975, 1355.5797702712389, 1384.439302082658, 1405.1428628536585, 1441.5242969819935, 23506.0, 30946.381072378877, 30969.0, 31215.0, 31658.525122122726, 46233.53766462292, 56123.0, 56474.717626411606, 56639.15041274467, 57295.1405728906, 480352.0, 485789.0, 489235.0, 493353.0, 494467.0, 41779.7911010443, 44120.55879441164, 44694.77652611716, 44906.0, 45062.87342816456, 44859.55140448554, 45999.0, 46941.0, 47179.76410117927, 47337.05325893394, 35620.0, 38442.615573845025, 38721.6127838718, 39372.409413858244, 39497.0, 38073.4288985671, 38240.426393603564, 38336.42495362627, 38526.80736596411, 38575.42136868005, 34374.31251375008, 35603.93188204358, 35754.64245357513, 35966.0, 36137.457938131476, 29700.366479843815, 34294.65705343014, 34490.0, 34550.82724586462, 34695.13262168466, 25481.74518254868, 25688.357791055372, 25844.0, 25916.35209119787, 26072.739272607032], "unit": "score", "name": "ext.html", "value": 19238.050577593727}, {"lowerIsBetter": false, "replicates": [362.4364113803035, 365.03448379037445, 365.0854609203944, 372.49712887601726, 373.40814808528484, 16049.438269660564, 19181.520461988457, 19792.703109453352, 20290.391288261377, 21019.47451313716, 16174.19129043549, 19927.402177934648, 19995.500112497193, 20009.399718008448, 20268.89865550674, 4944.0, 5619.353774315945, 5696.458836410535, 5896.174535565025, 5985.072313791369, 5818.156367326735, 5886.705664716768, 5927.170196172539, 5938.46553810157, 5941.673207973559, 4123.9793801030955, 5639.379668236491, 5879.706014699269, 5895.086261629433, 6223.097650840626, 6389.361063893597, 6401.871962560723, 6403.295637479897, 6439.098526206359, 6439.5170362223025, 5377.7311134443125, 5584.385717571064, 5591.6365436246515, 5594.524465420403, 5635.5773317001385, 24207.757922420726, 24254.39364015896, 24457.633135502983, 24482.510349792905, 24914.626280605804, 2047.7849825768378, 2125.0649714125734, 2163.697082408464, 2169.631162702344, 2226.77732226776, 9328.533573321374, 9803.90196098037, 10009.949950250275, 10116.443595602239, 14988.87583431247, 1742.6166243426426, 1789.677857985562, 1810.9637807243782, 1828.168183476515, 1846.7414561961336, 104592.0, 105077.42383864248, 105645.0, 106225.40661890077, 111671.0, 11272.492737826817, 11372.545098196146, 11389.601363952388, 11466.54133834654, 11472.827907581393, 13526.729465410637, 13607.047506674438, 13622.0, 13648.24934628605, 13680.452781888813, 7700.845983080307, 8045.0, 8468.703595374132, 8512.063672995966, 8528.445651032664, 7389.298016688406, 8512.574371281411, 8567.828643427221, 8625.91374086251, 8671.002834673967, 4425.933610995838, 4427.512973572904, 4513.954860451419, 4522.253828118323, 4555.316702494652, 1832.5052235896233, 1879.2483006797117, 1882.1248119624167, 1893.4792931943825, 1895.9052047397574, 389.8830350894777, 395.1918327021248, 406.45940898604783, 761.5735188294573, 946.7207173883721, 9691.418514889128, 11250.0, 11602.361870097056, 11787.705307367385, 11913.0, 443.9289713645866, 447.28211220990494, 454.7862504622888, 465.93243979622764, 469.1344469453852, 5947.851303717442, 6102.511799056065, 6102.603330783485, 6110.511159107261, 6135.32511423743, 510238.0, 558888.0, 586093.0, 638588.0, 643400.0, 97725.0, 105954.94045059451, 120014.0, 121924.39037804754, 123208.0, 1022.3661329975463, 1047.701405099543, 1063.3354153653966, 1064.861567996171, 1073.1254027967025, 18393.81606183921, 18498.075096245404, 18809.0, 18889.0, 19109.61780764349, 49241.50758492369, 50580.49419505758, 50947.2357914639, 51487.0, 53054.0, 55668.49491772961, 70620.64689676519, 71447.28552714406, 71537.64231179019, 72352.27647723455, 7874.37005039584, 7905.802354941173, 7988.520688758693, 8114.83770324602, 8179.345652347917, 9925.404475731479, 11832.580090389209, 12028.338441385458, 12526.686832829253, 13063.738725225632, 10867.782644346911, 10885.292455990335, 10911.454427278446, 11073.280236784583, 11137.721556960816, 9888.950555247466, 10699.0, 10745.355278683304, 10766.515506802056, 10772.461376931278, 10796.63631387763, 11114.888851111386, 11236.494357753758, 11306.547738090385, 11317.773644526898, 6489.610623362613, 8028.759137225892, 8085.231902969209, 8299.253067223979, 8308.5430301334, 7143.2499587544635, 8361.372897032868, 9981.101700846959, 10175.694729158136, 10380.688579342632], "unit": "score", "name": "jquery.html", "value": 8699.103524732831}, {"lowerIsBetter": false, "replicates": [1361.2649169448496, 1535.217039309952, 1723.8017627972788, 1868.3651804670912, 1877.1552801239445, 7803.0, 8474.940632420947, 8742.825143497126, 8899.733008009754, 8938.508382038985, 8602.956985215065, 8606.225439710424, 8711.215990560848, 8746.91253087469, 8749.912500874989, 2433.2092070077206, 2438.4635380216414, 2451.901923923041, 2453.50929814037, 2465.790407815338, 2416.930438714613, 2483.689538807649, 2498.2380373985925, 2501.6247562865624, 2504.5742223821903, 2157.7410710714657, 2393.8922748476275, 2451.080844683244, 2481.4788894332214, 2508.234988328559, 2426.5268272686835, 2458.323960910746, 2463.027104293812, 2466.728659847415, 2470.3206618180056, 2376.370261880603, 2398.784109430142, 2418.818588605844, 2420.891059902291, 2430.793382562467, 8633.266172375355, 8677.739667809976, 8681.956590217073, 8717.7820554486, 8751.912480875237, 4966.850994470172, 5212.40057393397, 5386.73066346685, 5490.780368785284, 5493.148561972901, 3583.068402215417, 3633.818309084535, 3673.3938900081453, 3720.5907350191455, 3723.0320116769835, 1052.3370276725614, 1055.166418529361, 1077.256692881909, 1085.2945585369573, 1087.8041952448557, 11844.407779610985, 11982.580609678707, 11995.64013079609, 12006.879931200663, 12051.939740301243, 4075.735077219971, 4831.73425461596, 4945.530174633404, 4957.405111386584, 5017.422996355466, 10090.949545252373, 10175.0, 10196.796064078677, 10218.693439196835, 10229.539670714836, 5416.160495123262, 5498.972505137529, 5520.944790552043, 5552.333719953632, 5554.833354999276, 5001.374828146481, 5010.098182327143, 5013.323201367842, 5029.622778291643, 5067.746612669352, 3271.3620843935205, 3972.1459886124044, 4020.8793736187963, 4043.332850079763, 4081.428599996003, 1309.2013871538354, 1325.7812460944028, 1326.6152815683536, 1340.2092765268537, 1352.9526466573623, 1018.2057994764095, 1109.4230999880017, 1135.432283858071, 1255.2719422734792, 1363.1684672349859, 7989.2809647132035, 8049.758507244792, 8107.55408452529, 8123.918760812317, 8174.509529428254, 1187.4062968515743, 1190.0657983483097, 1194.4027986006997, 1207.6799648093263, 1219.116140797932, 6074.817755467343, 6169.629822210592, 6232.532560058014, 6243.75024999004, 6255.74977000924, 10344.810346810063, 10542.683719488428, 10675.83986240207, 10701.411422371688, 10784.838227426595, 9289.792326997447, 10452.947735261276, 10516.789664206673, 10598.20513461478, 10598.576056957789, 6718.328167183243, 8267.0, 8395.454295470774, 8408.0, 8420.0, 7628.656710447932, 7999.360051196007, 8011.759647210593, 8028.558429286445, 8215.383846211678, 9456.196223321094, 9530.856297244098, 9622.13400793932, 9691.321607487409, 9812.901870981485, 9509.762255943657, 9719.0, 9789.412635241908, 10046.849297260693, 10087.848682269918, 6060.969695151496, 7484.0, 7520.398368130646, 7560.5841678706, 7568.735094271674, 8027.1972802719265, 8078.071021832329, 8088.433809633505, 8143.51138931666, 8144.981877265342, 6731.865362692621, 7233.674484648098, 7407.92592074094, 7444.516106453063, 7511.32398084175, 7221.169565500035, 7349.595772232578, 7367.4106071515225, 7376.373008294355, 7448.031755871702, 7702.730404435818, 7770.844583108419, 7791.727289544839, 7792.922070779219, 7839.176886426843, 6956.0, 7053.6825842838225, 7094.290570942864, 7099.432045436456, 7102.786916392516, 7052.612106333996, 7141.9642901785155, 7165.964170179324, 7186.173590037003, 7198.5320954137815], "unit": "score", "name": "mootools.html", "value": 4938.801140609549}, {"lowerIsBetter": false, "replicates": [276.30371463910933, 323.2694111308443, 328.566292493908, 332.49626815374705, 336.39952684458245, 5301.6818990860575, 6644.700988455519, 6805.591664500121, 6882.965585172074, 6911.412529934962, 6678.198616166054, 6801.591904485735, 6803.591784492934, 6839.247682754893, 6869.519133660646, 4985.476524964881, 4987.326710894019, 4994.0, 5001.049800537886, 5007.724575148365, 4989.077020751154, 4997.975010124945, 5009.998000399916, 5022.472640372763, 5026.070177017245, 4956.578690811268, 4964.0, 4964.205727083668, 4965.180745177059, 4979.825706100287, 4059.451973983504, 4677.0, 4850.175470170045, 4906.969536397343, 4984.32711583937, 4048.1903619276263, 4088.5093788745244, 4092.0, 4110.362893751473, 4118.320477121271, 6399.296077431479, 6428.839279018062, 6447.0, 6458.547901646886, 6467.288598254188, 4608.516105808875, 5573.665580065209, 5744.540436765049, 5771.336296325934, 5777.826665200051, 7125.679344429514, 7133.8216544586285, 7142.607156606385, 7146.928530714678, 7151.570905745672, 4129.988152902528, 4228.386883901848, 4592.2422800238255, 4599.586037256663, 4622.14490319292, 6906.791311520464, 7567.0, 7673.237634451593, 7691.961540192263, 7692.884606730903, 4183.895402614959, 4462.709923854939, 4547.636189104864, 4579.9542004579525, 4670.883227919261, 4740.360051393018, 4744.739039352799, 4751.311059896296, 4765.642576806753, 4766.0, 5709.714514274269, 5711.7144142792695, 5722.62802917809, 5729.9713501432225, 5730.426957304237, 5857.824265272048, 7123.430125590044, 7268.745593904294, 7274.418046556263, 7350.816229594196, 1256.1897576063388, 1557.844215578433, 1610.5570967983663, 1626.9267882945296, 1663.6173680053655, 1040.9850395864123, 1044.3577200022085, 1051.7633532455136, 1055.4775386183887, 1059.5549869055014, 6090.63456192621, 6155.645757933247, 6710.530262881649, 6736.5958042517605, 6737.292584278678, 5748.425157484218, 7110.8978108393285, 7435.814104647319, 7472.29013243741, 7510.436717246228, 6694.531382803157, 6736.427403670743, 6741.561798483083, 6761.425278851254, 6764.526483146133, 3929.0, 3941.3890846918775, 3960.029792700749, 3976.224636195972, 3985.980070099631, 6985.637800628829, 7169.928300717031, 7178.712851485987, 7803.531788092732, 7852.803679908048, 7742.806429839299, 7751.573663448565, 7751.651175696994, 7769.72805951789, 7873.527588344603, 7870.9606451967375, 7900.881486777588, 7912.169222231582, 7914.169012253861, 7914.406419518559, 6025.578209525466, 6860.456397310565, 6878.793636190922, 7588.696452141852, 7599.392048635986, 7214.567125972459, 7398.408127349691, 7435.367993720594, 7449.020391843306, 7463.552186868806, 6598.769043083469, 7877.369810415267, 7917.2874441300555, 7926.167752385916, 7949.0, 4697.976510117427, 4703.905921881612, 4705.976470117627, 4707.411573553306, 4758.738269395217, 7250.9637451812405, 7495.850082998419, 7518.060242469692, 7527.247275272648, 7538.962305188439, 6182.412670796267, 6999.930000699927, 7223.602701851239, 7267.563946163247, 7323.9267607323245, 5889.0, 7272.0, 7289.963550182215, 7291.161516425467, 7306.452016098708, 7103.076600041962, 7110.928890711027, 7120.821979450555, 7124.964375178091, 7139.071920650283, 7059.258777828254, 7263.455240856852, 7295.635218239173, 7297.087864016998, 7301.379382752525, 5882.23530940975, 6961.060256865258, 7062.293770622897, 7063.25835787235, 7076.398506127037], "unit": "score", "name": "prototype.html", "value": 5180.968050241474}, {"lowerIsBetter": false, "replicates": [650.0208403628209, 707.2821086597102, 727.2291371146586, 738.0000099864683, 738.4941315199093, 11311.886881131186, 14551.126932384064, 14666.706665866675, 14673.192974386404, 14732.0, 13286.870615997652, 13352.198868067899, 13406.530771423002, 13440.93279533601, 13485.797713034312, 702.388921638173, 849.1041950741949, 850.421713235, 870.3472395703222, 883.4964070479829, 862.6678728689468, 868.3921255121409, 869.656485688156, 870.3776799588293, 875.8204568063563, 908.1100521488945, 919.9172074513292, 923.5474617437475, 923.9538023098818, 925.9120383563584, 898.4160295807744, 900.8603666431713, 910.3900386740834, 916.1067958740242, 917.8118485710413, 660.4089340040637, 672.1228796420669, 685.7702669605688, 686.084077756196, 686.5708931917552, 14157.575272741835, 14415.855841441557, 14520.056196347203, 14530.782038269434, 14629.707405851823, 12635.810462843065, 12686.619401417973, 12748.872511274862, 12788.552400665933, 13033.283169425678, 8525.50105182154, 10426.061654451136, 10794.622188223375, 10963.780724385548, 11551.53793848245, 3472.861085556575, 3478.2000139967695, 3508.2281897982402, 3512.947305790415, 3518.36669399508, 83787.16212837855, 83916.16083839144, 84066.0, 85334.71997920037, 86943.13056869413, 9187.862182067274, 9382.953085234667, 9400.341976061747, 9446.669366572138, 9649.951750241204, 20425.591488170154, 20528.486787830127, 20648.070836812378, 20677.379678609665, 20729.170833166503, 7212.098487689039, 7423.480356375002, 7434.7769566913075, 7580.772576822704, 7705.460617756703, 3966.8809935701975, 3998.1204135090234, 4020.638142567183, 4036.535798383165, 4041.9797901010306, 3425.811580363054, 3453.9654603453646, 3469.098034511045, 3472.2361080562237, 3473.565804274466, 625.3683779382765, 635.5741653092439, 635.845939619589, 656.9146011018537, 659.2846761264083, 560.1737437280061, 587.8030859662061, 596.6420147911218, 614.1923370767427, 616.8673735146965, 8352.331813454908, 8487.36344774132, 8502.532360720095, 8662.566871656392, 8701.912980870236, 499.6777078784164, 527.3750605532456, 578.1472328315784, 610.9358517355703, 659.8086554899121, 3815.6184381562175, 3967.821448034845, 4072.898177545585, 4298.505671847715, 4335.653147748172, 89329.0, 89508.0, 89989.0, 90447.0, 91107.54446227726, 75522.62238688882, 77733.6113319441, 78052.2194778045, 82137.58931205305, 82569.58715206505, 65569.01646475306, 66440.66779666167, 66504.0, 67054.99417508741, 67740.0, 7404.777856664308, 8587.441816281922, 8836.160564746338, 8912.955435222782, 8945.507997059964, 44376.0, 45081.32378014398, 45344.0, 45638.54361456343, 46026.84932876705, 59800.40199597948, 60355.0, 60573.39426605678, 60913.402144024156, 61152.471188220654, 10758.354498730101, 10888.61889833852, 10897.073748731447, 10995.945020274847, 11279.32324060559, 11841.28952262867, 11956.402179890796, 12102.092343074128, 12329.815052774036, 12368.690782730504, 10031.29780915329, 10796.460176991277, 10845.511951962022, 11572.735671922073, 11740.29558226475, 9257.259419246579, 10559.208059395729, 10777.13782897382, 11172.776544469227, 11881.405929703653, 10928.781424371628, 11253.099752019654, 11431.942840285745, 11544.711382215512, 11918.344491053076, 9247.537623118951, 9382.967873534042, 9479.857802132836, 9757.170640495637, 10206.642767503101, 7969.960150199444, 8639.352048596505, 9155.404898681565, 9200.723978280663, 9907.108360247612], "unit": "score", "name": "yui.html", "value": 6780.502213451775}], "name": "dromaeo_css", "value": 7386.484396517597}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 150.0, 98.0, 135.0, 167.0, 184.0, 114.0, 115.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 130.3}, {"lowerIsBetter": true, "replicates": [155.0, 125.0, 142.0, 162.0, 157.0, 141.0, 140.0, 133.0, 178.0, 148.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [199.0, 192.0, 197.0, 229.0, 270.0, 210.0, 198.0, 194.0, 197.0, 196.0], "unit": "score", "name": "audio-dft", "value": 208.2}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 72.0, 105.0, 59.0, 55.0, 59.0, 59.0, 115.0, 57.0], "unit": "score", "name": "audio-fft", "value": 72.3}, {"lowerIsBetter": true, "replicates": [87.0, 81.0, 124.0, 94.0, 121.0, 122.0, 138.0, 82.0, 82.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 104.5}, {"lowerIsBetter": true, "replicates": [107.0, 120.0, 131.0, 118.0, 88.0, 142.0, 86.0, 92.0, 108.0, 120.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 111.2}, {"lowerIsBetter": true, "replicates": [94.0, 99.0, 140.0, 151.0, 117.0, 95.0, 97.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 107.9}, {"lowerIsBetter": true, "replicates": [77.0, 154.0, 152.0, 99.0, 92.0, 90.0, 91.0, 90.0, 91.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 102.8}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 64.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 69.0, 79.0, 92.0, 101.0, 65.0, 69.0, 83.0, 100.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 79.0}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 86.0, 84.0, 90.0, 84.0, 85.0, 88.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [151.0, 143.0, 143.0, 122.0, 138.0, 130.0, 134.0, 116.0, 124.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.5}, {"lowerIsBetter": true, "replicates": [130.0, 143.0, 154.0, 156.0, 135.0, 183.0, 183.0, 160.0, 170.0, 174.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 158.8}, {"lowerIsBetter": true, "replicates": [60.0, 96.0, 60.0, 85.0, 69.0, 67.0, 82.0, 98.0, 99.0, 93.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 80.9}], "name": "kraken", "value": 1579.6}]} 01:26:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1579.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7386.48"}}} 01:26:03 INFO - Return code: 0 01:26:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:26:04 ERROR - # TBPL SUCCESS # 01:26:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:26:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:26:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:26:04 INFO - 2016-02-25 01:26:04.052 screenresolution[1692:11096] starting screenresolution argv=screenresolution get 01:26:04 INFO - 2016-02-25 01:26:04.055 screenresolution[1692:11096] Display 0: 1600x1200x32@60 01:26:04 INFO - 2016-02-25 01:26:04.061 screenresolution[1693:11099] starting screenresolution argv=screenresolution list 01:26:04 INFO - Available Modes on Display 0 01:26:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:26:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:26:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:26:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:26:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:26:04 INFO - Intel Iris: 01:26:04 INFO - Chipset Model: Intel Iris 01:26:04 INFO - Type: GPU 01:26:04 INFO - Bus: Built-In 01:26:04 INFO - VRAM (Dynamic, Max): 1536 MB 01:26:04 INFO - Vendor: Intel (0x8086) 01:26:04 INFO - Device ID: 0x0a2e 01:26:04 INFO - Revision ID: 0x0009 01:26:04 INFO - Displays: 01:26:04 INFO - Display: 01:26:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:26:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:26:04 INFO - Display Serial Number: 1600x1200 60 01:26:04 INFO - Main Display: Yes 01:26:04 INFO - Mirror: Off 01:26:04 INFO - Online: Yes 01:26:04 INFO - Rotation: Supported 01:26:04 INFO - Return code: 0 01:26:04 INFO - Running post-action listener: _resource_record_post_action 01:26:04 INFO - Running post-run listener: _resource_record_post_run 01:26:05 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 34053632; Write bytes: 711772672; Read time: 356; Write time: 1920 01:26:05 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391326208; Write bytes: 386571776; Read time: 29078; Write time: 685 01:26:05 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 33009152; Write bytes: 303991808; Read time: 341; Write time: 1192 01:26:05 INFO - Running post-run listener: _upload_blobber_files 01:26:05 INFO - Blob upload gear active. 01:26:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:26:05 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 01:26:05 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'] 01:26:05 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 01:26:05 INFO - (blobuploader) - INFO - Open directory for files ... 01:26:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:26:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:26:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:26:06 INFO - (blobuploader) - INFO - Done attempting. 01:26:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:26:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:26:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:26:07 INFO - (blobuploader) - INFO - Done attempting. 01:26:07 INFO - (blobuploader) - INFO - Iteration through files over. 01:26:07 INFO - Return code: 0 01:26:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:26:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:26:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8fd71b0af2629c34706fcd5157573c0e5b371b5e0a0c50e5079a487109fe79a04dadb4ea7151485a80be9d0c8a08d01f64401c2dac42e84fa89f15d3e461064", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49979f8fb3a5f61cb77be93838fb053c42ab593b1a7acdca103294b9916357d98f4b854381f53eba3a8fb6c593b782b74bb3d125b345ef7655f0c991db836ac6"} 01:26:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:26:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:26:07 INFO - Contents: 01:26:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8fd71b0af2629c34706fcd5157573c0e5b371b5e0a0c50e5079a487109fe79a04dadb4ea7151485a80be9d0c8a08d01f64401c2dac42e84fa89f15d3e461064", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49979f8fb3a5f61cb77be93838fb053c42ab593b1a7acdca103294b9916357d98f4b854381f53eba3a8fb6c593b782b74bb3d125b345ef7655f0c991db836ac6"} 01:26:07 INFO - Running post-run listener: copy_logs_to_upload_dir 01:26:07 INFO - Copying logs to upload dir... 01:26:07 INFO - mkdir: /builds/slave/test/build/upload/logs 01:26:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.038537 ========= master_lag: 2.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-02-25 01:26:10.479097) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 01:26:10.482265) ========= 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.C2T0D58UBJ/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.CjnKssxtOK/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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/d8fd71b0af2629c34706fcd5157573c0e5b371b5e0a0c50e5079a487109fe79a04dadb4ea7151485a80be9d0c8a08d01f64401c2dac42e84fa89f15d3e461064", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49979f8fb3a5f61cb77be93838fb053c42ab593b1a7acdca103294b9916357d98f4b854381f53eba3a8fb6c593b782b74bb3d125b345ef7655f0c991db836ac6"} build_url:https://queue.taskcluster.net/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010973 build_url: 'https://queue.taskcluster.net/v1/task/f1VGRSOaSoeU-TgRPJUbaw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8fd71b0af2629c34706fcd5157573c0e5b371b5e0a0c50e5079a487109fe79a04dadb4ea7151485a80be9d0c8a08d01f64401c2dac42e84fa89f15d3e461064", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49979f8fb3a5f61cb77be93838fb053c42ab593b1a7acdca103294b9916357d98f4b854381f53eba3a8fb6c593b782b74bb3d125b345ef7655f0c991db836ac6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 01:26:10.526696) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:26:10.527071) ========= 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.C2T0D58UBJ/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.CjnKssxtOK/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005181 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:26:10.576649) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 01:26:10.578599) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 01:26:10.579037) ========= ========= Total master_lag: 16.16 =========