builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0154 starttime: 1455044953.45 results: success (0) buildid: 20160209083856 builduid: 403f360bd5a141d983f8512961491f49 revision: 9799df240b379e461fd1ea9dedea3bbe7dfb9631 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.447344) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.447748) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.448029) ========= 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.RSUyABnMPP/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.fmzXxmJFNK/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.005541 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.469647) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.469925) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.484017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.484363) ========= 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.RSUyABnMPP/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.fmzXxmJFNK/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.005416 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.535011) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.535326) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.535704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.535979) ========= 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.RSUyABnMPP/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.fmzXxmJFNK/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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-09 11:09:13-- 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% 7.99M=0.001s 2016-02-09 11:09:13 (7.99 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125355 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.753830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.754155) ========= 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.RSUyABnMPP/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.fmzXxmJFNK/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.019733 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:13.859184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 11:09:13.859525) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9799df240b379e461fd1ea9dedea3bbe7dfb9631 --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 9799df240b379e461fd1ea9dedea3bbe7dfb9631 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RSUyABnMPP/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.fmzXxmJFNK/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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-09 11:09:13,926 truncating revision to first 12 chars 2016-02-09 11:09:13,926 Setting DEBUG logging. 2016-02-09 11:09:13,927 attempt 1/10 2016-02-09 11:09:13,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9799df240b37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 11:09:14,690 unpacking tar archive at: fx-team-9799df240b37/testing/mozharness/ program finished with exit code 0 elapsedTime=1.000734 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 11:09:14.891108) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:14.891529) ========= echo 9799df240b379e461fd1ea9dedea3bbe7dfb9631 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9799df240b379e461fd1ea9dedea3bbe7dfb9631'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RSUyABnMPP/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.fmzXxmJFNK/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 9799df240b379e461fd1ea9dedea3bbe7dfb9631 program finished with exit code 0 elapsedTime=0.005205 script_repo_revision: '9799df240b379e461fd1ea9dedea3bbe7dfb9631' ========= master_lag: 0.35 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:15.249746) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:15.250068) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 11:09:15.273382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-02-09 11:09:15.273758) ========= /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.RSUyABnMPP/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.fmzXxmJFNK/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 11:09:15 INFO - MultiFileLogger online at 20160209 11:09:15 in /builds/slave/test 11:09:15 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 11:09:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:09:15 INFO - {'append_to_log': False, 11:09:15 INFO - 'base_work_dir': '/builds/slave/test', 11:09:15 INFO - 'blob_upload_branch': 'Fx-Team', 11:09:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:09:15 INFO - 'branch': 'Fx-Team', 11:09:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:09:15 INFO - 'config_files': ('talos/mac_config.py',), 11:09:15 INFO - 'default_actions': ('clobber', 11:09:15 INFO - 'read-buildbot-config', 11:09:15 INFO - 'download-and-extract', 11:09:15 INFO - 'populate-webroot', 11:09:15 INFO - 'create-virtualenv', 11:09:15 INFO - 'install', 11:09:15 INFO - 'run-tests'), 11:09:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:09:15 INFO - 'download_minidump_stackwalk': True, 11:09:15 INFO - 'download_symbols': 'ondemand', 11:09:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:09:15 INFO - 'tooltool.py': '/tools/tooltool.py', 11:09:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:09:15 INFO - '/tools/misc-python/virtualenv.py')}, 11:09:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:09:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:09:15 INFO - 'installer_path': 'installer.exe', 11:09:15 INFO - 'log_level': 'info', 11:09:15 INFO - 'log_name': 'talos', 11:09:15 INFO - 'log_to_console': True, 11:09:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:09:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:09:15 INFO - 'opt_config_files': (), 11:09:15 INFO - 'pip_index': False, 11:09:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:09:15 INFO - 'cmd': ('bash', 11:09:15 INFO - '-c', 11:09:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:09:15 INFO - 'enabled': True, 11:09:15 INFO - 'halt_on_failure': False, 11:09:15 INFO - 'name': 'check_screen_resolution'},), 11:09:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:09:15 INFO - 'cmd': ('bash', 11:09:15 INFO - '-c', 11:09:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:09:15 INFO - 'enabled': True, 11:09:15 INFO - 'halt_on_failure': False, 11:09:15 INFO - 'name': 'check_screen_resolution'},), 11:09:15 INFO - 'run_cmd_checks_enabled': True, 11:09:15 INFO - 'sps_profile': False, 11:09:15 INFO - 'sps_profile_interval': 0, 11:09:15 INFO - 'suite': 'dromaeojs-e10s', 11:09:15 INFO - 'system_bits': '32', 11:09:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:09:15 INFO - 'title': 't-yosemite-r7-0154', 11:09:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:09:15 INFO - 'use_talos_json': True, 11:09:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:09:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:09:15 INFO - 'work_dir': 'build'} 11:09:15 INFO - ##### 11:09:15 INFO - ##### Running clobber step. 11:09:15 INFO - ##### 11:09:15 INFO - Running pre-action listener: _resource_record_pre_action 11:09:15 INFO - Running main action method: clobber 11:09:15 INFO - rmtree: /builds/slave/test/build 11:09:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:09:16 INFO - Running post-action listener: _resource_record_post_action 11:09:16 INFO - ##### 11:09:16 INFO - ##### Running read-buildbot-config step. 11:09:16 INFO - ##### 11:09:16 INFO - Running pre-action listener: _resource_record_pre_action 11:09:16 INFO - Running main action method: read_buildbot_config 11:09:16 INFO - Using buildbot properties: 11:09:16 INFO - { 11:09:16 INFO - "project": "", 11:09:16 INFO - "product": "firefox", 11:09:16 INFO - "script_repo_revision": "production", 11:09:16 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:09:16 INFO - "repository": "", 11:09:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:09:16 INFO - "buildid": "20160209083856", 11:09:16 INFO - "pgo_build": "False", 11:09:16 INFO - "basedir": "/builds/slave/test", 11:09:16 INFO - "buildnumber": 414, 11:09:16 INFO - "slavename": "t-yosemite-r7-0154", 11:09:16 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:09:16 INFO - "platform": "yosemite_r7", 11:09:16 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:09:16 INFO - "branch": "fx-team", 11:09:16 INFO - "repo_path": "integration/fx-team", 11:09:16 INFO - "revision": "9799df240b379e461fd1ea9dedea3bbe7dfb9631", 11:09:16 INFO - "stage_platform": "macosx64", 11:09:16 INFO - "builduid": "403f360bd5a141d983f8512961491f49", 11:09:16 INFO - "slavebuilddir": "test" 11:09:16 INFO - } 11:09:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 11:09:16 INFO - Running post-action listener: _resource_record_post_action 11:09:16 INFO - ##### 11:09:16 INFO - ##### Running download-and-extract step. 11:09:16 INFO - ##### 11:09:16 INFO - Running pre-action listener: _resource_record_pre_action 11:09:16 INFO - Running main action method: download_and_extract 11:09:16 INFO - mkdir: /builds/slave/test/build/tests 11:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:16 INFO - https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:09:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/test_packages.json 11:09:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/test_packages.json 11:09:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:09:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:09:18 INFO - Downloaded 1277 bytes. 11:09:18 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:09:18 INFO - Using the following test package requirements: 11:09:18 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:09:18 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:09:18 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 11:09:18 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:09:18 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 11:09:18 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:09:18 INFO - u'jsshell-mac.zip'], 11:09:18 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:09:18 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 11:09:18 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:09:18 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:09:18 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 11:09:18 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:09:18 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 11:09:18 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:09:18 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 11:09:18 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:09:18 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:09:18 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 11:09:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:09: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')]} 11:09:18 INFO - https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:09:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:09:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:09:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 11:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 11:09:19 INFO - Downloaded 17747173 bytes. 11:09:19 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'] 11:09:19 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 11:09:22 INFO - Return code: 0 11:09:22 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 11:09:22 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')]} 11:09:22 INFO - https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:09:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:09:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:09:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 11:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 11:09:23 INFO - Downloaded 17747173 bytes. 11:09:23 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'] 11:09:23 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 11:09:27 INFO - Return code: 0 11:09: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')]} 11:09:27 INFO - https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 11:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 11:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 11:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 11:09:28 INFO - Downloaded 10706547 bytes. 11:09:28 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'] 11:09:28 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 11:09:28 INFO - Return code: 0 11:09:28 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')]} 11:09:28 INFO - https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 11:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 11:09:31 INFO - Downloaded 111247204 bytes. 11:09:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:09:31 INFO - mkdir: /builds/slave/test/properties 11:09:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:09:31 INFO - Writing to file /builds/slave/test/properties/build_url 11:09:31 INFO - Contents: 11:09:31 INFO - build_url:https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:09:32 INFO - Running post-action listener: _resource_record_post_action 11:09:32 INFO - Running post-action listener: set_extra_try_arguments 11:09:32 INFO - ##### 11:09:32 INFO - ##### Running populate-webroot step. 11:09:32 INFO - ##### 11:09:32 INFO - Running pre-action listener: _resource_record_pre_action 11:09:32 INFO - Running main action method: populate_webroot 11:09:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:09:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:09:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:09:32 INFO - '--tppagecycles', 11:09:32 INFO - '7'], 11:09:32 INFO - 'tests': ['tsvgm']}}, 11:09:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:09:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:09:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:09:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:09:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:09:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:09:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:32 INFO - 'talos_options': ['--e10s'], 11:09:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:32 INFO - 'tests': ['damp', 'tps']}, 11:09:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:32 INFO - 'talos_options': ['--e10s'], 11:09:32 INFO - 'tests': ['damp', 'tps']}, 11:09:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:09:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:09:32 INFO - 'other': {'tests': ['a11yr', 11:09:32 INFO - 'ts_paint', 11:09:32 INFO - 'tpaint', 11:09:32 INFO - 'sessionrestore', 11:09:32 INFO - 'sessionrestore_no_auto_restore']}, 11:09:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:09:32 INFO - 'tests': ['a11yr', 11:09:32 INFO - 'ts_paint', 11:09:32 INFO - 'tpaint', 11:09:32 INFO - 'sessionrestore', 11:09:32 INFO - 'sessionrestore_no_auto_restore']}, 11:09:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:09:32 INFO - 'tests': ['a11yr', 11:09:32 INFO - 'ts_paint', 11:09:32 INFO - 'tpaint', 11:09:32 INFO - 'sessionrestore', 11:09:32 INFO - 'sessionrestore_no_auto_restore']}, 11:09:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:09:32 INFO - 'tests': ['a11yr', 11:09:32 INFO - 'ts_paint', 11:09:32 INFO - 'tpaint', 11:09:32 INFO - 'sessionrestore', 11:09:32 INFO - 'sessionrestore_no_auto_restore']}, 11:09:32 INFO - 'other_l64': {'tests': ['a11yr', 11:09:32 INFO - 'ts_paint', 11:09:32 INFO - 'tpaint', 11:09:32 INFO - 'sessionrestore', 11:09:32 INFO - 'sessionrestore_no_auto_restore']}, 11:09:32 INFO - 'other_nol64': {'tests': ['a11yr', 11:09:32 INFO - 'ts_paint', 11:09:32 INFO - 'tpaint', 11:09:32 INFO - 'sessionrestore', 11:09:32 INFO - 'sessionrestore_no_auto_restore']}, 11:09:32 INFO - 'svgr': {'tests': ['tsvgx', 11:09:32 INFO - 'tsvgr_opacity', 11:09:32 INFO - 'tart', 11:09:32 INFO - 'tscrollx', 11:09:32 INFO - 'cart']}, 11:09:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:09:32 INFO - 'tests': ['tsvgx', 11:09:32 INFO - 'tsvgr_opacity', 11:09:32 INFO - 'tart', 11:09:32 INFO - 'tscrollx', 11:09:32 INFO - 'cart']}, 11:09:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:32 INFO - 'tests': ['tp5o']}, 11:09:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:32 INFO - 'talos_options': ['--e10s'], 11:09:32 INFO - 'tests': ['tp5o']}, 11:09:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:32 INFO - 'talos_options': ['--xperf_path', 11:09:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:32 INFO - 'tests': ['tp5n']}, 11:09:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:32 INFO - 'talos_options': ['--e10s', 11:09:32 INFO - '--xperf_path', 11:09:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:32 INFO - 'tests': ['tp5n']}}, 11:09:32 INFO - 'talos.zip': {'path': '', 11:09:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:09:32 INFO - Running post-action listener: _resource_record_post_action 11:09:32 INFO - ##### 11:09:32 INFO - ##### Running create-virtualenv step. 11:09:32 INFO - ##### 11:09:32 INFO - Running pre-action listener: _resource_record_pre_action 11:09:32 INFO - Running main action method: create_virtualenv 11:09:32 INFO - Creating virtualenv /builds/slave/test/build/venv 11:09:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:09:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:09:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:09:32 INFO - Using real prefix '/tools/python27' 11:09:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:09:33 INFO - Installing distribute.............................................................................................................................................................................................done. 11:09:36 INFO - Installing pip.................done. 11:09:36 INFO - Return code: 0 11:09:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dcfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dd64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb704b42b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c73d30>, '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 0x104a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ab20>, '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.RSUyABnMPP/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.fmzXxmJFNK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 11:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RSUyABnMPP/Render', 11:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:36 INFO - 'HOME': '/Users/cltbld', 11:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:36 INFO - 'LOGNAME': 'cltbld', 11:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:36 INFO - 'MOZ_NO_REMOTE': '1', 11:09:36 INFO - 'NO_EM_RESTART': '1', 11:09:36 INFO - 'PAGER': '/bin/cat', 11:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:36 INFO - 'PWD': '/builds/slave/test', 11:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:36 INFO - 'SHELL': '/bin/bash', 11:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmzXxmJFNK/Listeners', 11:09:36 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 11:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:36 INFO - 'USER': 'cltbld', 11:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:36 INFO - 'XPC_FLAGS': '0x0', 11:09:36 INFO - 'XPC_SERVICE_NAME': '0', 11:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:09:36 INFO - Cleaning up... 11:09:36 INFO - Return code: 0 11:09:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dcfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dd64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb704b42b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c73d30>, '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 0x104a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ab20>, '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.RSUyABnMPP/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.fmzXxmJFNK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 11:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RSUyABnMPP/Render', 11:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:36 INFO - 'HOME': '/Users/cltbld', 11:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:36 INFO - 'LOGNAME': 'cltbld', 11:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:36 INFO - 'MOZ_NO_REMOTE': '1', 11:09:36 INFO - 'NO_EM_RESTART': '1', 11:09:36 INFO - 'PAGER': '/bin/cat', 11:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:36 INFO - 'PWD': '/builds/slave/test', 11:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:36 INFO - 'SHELL': '/bin/bash', 11:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmzXxmJFNK/Listeners', 11:09:36 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 11:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:36 INFO - 'USER': 'cltbld', 11:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:36 INFO - 'XPC_FLAGS': '0x0', 11:09:36 INFO - 'XPC_SERVICE_NAME': '0', 11:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:36 INFO - Downloading/unpacking psutil>=0.7.1 11:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:39 INFO - Installing collected packages: psutil 11:09:39 INFO - Running setup.py install for psutil 11:09:39 INFO - building 'psutil._psutil_osx' extension 11:09:39 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 11:09:39 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 11:09:39 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 11:09:39 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 11:09:39 INFO - building 'psutil._psutil_posix' extension 11:09:39 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 11:09:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:09:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:09:39 INFO - ^ 11:09:40 INFO - 1 warning generated. 11:09:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:09:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:40 INFO - Successfully installed psutil 11:09:40 INFO - Cleaning up... 11:09:40 INFO - Return code: 0 11:09:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dcfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dd64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb704b42b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c73d30>, '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 0x104a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ab20>, '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.RSUyABnMPP/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.fmzXxmJFNK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 11:09:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:09:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RSUyABnMPP/Render', 11:09:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:40 INFO - 'HOME': '/Users/cltbld', 11:09:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:40 INFO - 'LOGNAME': 'cltbld', 11:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:40 INFO - 'MOZ_NO_REMOTE': '1', 11:09:40 INFO - 'NO_EM_RESTART': '1', 11:09:40 INFO - 'PAGER': '/bin/cat', 11:09:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:40 INFO - 'PWD': '/builds/slave/test', 11:09:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:40 INFO - 'SHELL': '/bin/bash', 11:09:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmzXxmJFNK/Listeners', 11:09:40 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 11:09:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:40 INFO - 'USER': 'cltbld', 11:09:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:40 INFO - 'XPC_FLAGS': '0x0', 11:09:40 INFO - 'XPC_SERVICE_NAME': '0', 11:09:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:09:40 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 11:09:40 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 11:09:40 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 11:09:40 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 11:09:40 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 11:09:40 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 11:09:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:09:42 INFO - Installing collected packages: mozsystemmonitor 11:09:42 INFO - Running setup.py install for mozsystemmonitor 11:09:43 INFO - Successfully installed mozsystemmonitor 11:09:43 INFO - Cleaning up... 11:09:43 INFO - Return code: 0 11:09:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dcfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dd64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb704b42b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c73d30>, '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 0x104a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ab20>, '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.RSUyABnMPP/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.fmzXxmJFNK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 11:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RSUyABnMPP/Render', 11:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:43 INFO - 'HOME': '/Users/cltbld', 11:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:43 INFO - 'LOGNAME': 'cltbld', 11:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:43 INFO - 'MOZ_NO_REMOTE': '1', 11:09:43 INFO - 'NO_EM_RESTART': '1', 11:09:43 INFO - 'PAGER': '/bin/cat', 11:09:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:43 INFO - 'PWD': '/builds/slave/test', 11:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:43 INFO - 'SHELL': '/bin/bash', 11:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmzXxmJFNK/Listeners', 11:09:43 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 11:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:43 INFO - 'USER': 'cltbld', 11:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:43 INFO - 'XPC_FLAGS': '0x0', 11:09:43 INFO - 'XPC_SERVICE_NAME': '0', 11:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:43 INFO - Downloading/unpacking blobuploader==1.2.4 11:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:45 INFO - Downloading blobuploader-1.2.4.tar.gz 11:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:09:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:09:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09:46 INFO - Downloading docopt-0.6.1.tar.gz 11:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:09:46 INFO - Installing collected packages: blobuploader, requests, docopt 11:09:46 INFO - Running setup.py install for blobuploader 11:09:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:09:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:09:46 INFO - Running setup.py install for requests 11:09:47 INFO - Running setup.py install for docopt 11:09:47 INFO - Successfully installed blobuploader requests docopt 11:09:47 INFO - Cleaning up... 11:09:47 INFO - Return code: 0 11:09:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:47 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')]} 11:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:47 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')]} 11:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:47 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 0x104dcfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dd64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb704b42b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c73d30>, '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 0x104a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ab20>, '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.RSUyABnMPP/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.fmzXxmJFNK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 11:09:47 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 11:09:47 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 11:09:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RSUyABnMPP/Render', 11:09:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:47 INFO - 'HOME': '/Users/cltbld', 11:09:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:47 INFO - 'LOGNAME': 'cltbld', 11:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:47 INFO - 'MOZ_NO_REMOTE': '1', 11:09:47 INFO - 'NO_EM_RESTART': '1', 11:09:47 INFO - 'PAGER': '/bin/cat', 11:09:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:47 INFO - 'PWD': '/builds/slave/test', 11:09:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:47 INFO - 'SHELL': '/bin/bash', 11:09:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmzXxmJFNK/Listeners', 11:09:47 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 11:09:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:47 INFO - 'USER': 'cltbld', 11:09:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:47 INFO - 'XPC_FLAGS': '0x0', 11:09:47 INFO - 'XPC_SERVICE_NAME': '0', 11:09:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:47 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-6JB6OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:48 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-9vshmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:48 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-QNhHQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:48 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-m6FPBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:48 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-mOIWsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:48 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-p8xTm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:48 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-GBL6Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:48 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-zxgUoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:48 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-vcFFXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:48 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-WUYmOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:48 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-MNPm5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:49 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-y2Uid0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:49 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-ag41OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:49 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-jv6AM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:49 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-B_VTQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:49 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-0FHzQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:49 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-DbQcDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:09:49 INFO - Running setup.py install for manifestparser 11:09:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:09:49 INFO - Running setup.py install for mozcrash 11:09:50 INFO - Running setup.py install for mozdebug 11:09:50 INFO - Running setup.py install for mozdevice 11:09:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Running setup.py install for mozfile 11:09:50 INFO - Running setup.py install for mozhttpd 11:09:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Running setup.py install for mozinfo 11:09:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Running setup.py install for mozInstall 11:09:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:09:50 INFO - Running setup.py install for mozleak 11:09:51 INFO - Running setup.py install for mozlog 11:09:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:09:51 INFO - Running setup.py install for moznetwork 11:09:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:09:51 INFO - Running setup.py install for mozprocess 11:09:51 INFO - Running setup.py install for mozprofile 11:09:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:09:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:09:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:09:51 INFO - Running setup.py install for mozrunner 11:09:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:09:51 INFO - Running setup.py install for mozscreenshot 11:09:51 INFO - Running setup.py install for moztest 11:09:52 INFO - Running setup.py install for mozversion 11:09:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:09:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:09:52 INFO - Cleaning up... 11:09:52 INFO - Return code: 0 11:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09: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')]} 11:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09: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')]} 11:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dcfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dd64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb704b42b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c73d30>, '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 0x104a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ab20>, '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.RSUyABnMPP/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.fmzXxmJFNK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 11:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RSUyABnMPP/Render', 11:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:52 INFO - 'HOME': '/Users/cltbld', 11:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:52 INFO - 'LOGNAME': 'cltbld', 11:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:52 INFO - 'MOZ_NO_REMOTE': '1', 11:09:52 INFO - 'NO_EM_RESTART': '1', 11:09:52 INFO - 'PAGER': '/bin/cat', 11:09:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:52 INFO - 'PWD': '/builds/slave/test', 11:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:52 INFO - 'SHELL': '/bin/bash', 11:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmzXxmJFNK/Listeners', 11:09:52 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 11:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:52 INFO - 'USER': 'cltbld', 11:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:52 INFO - 'XPC_FLAGS': '0x0', 11:09:52 INFO - 'XPC_SERVICE_NAME': '0', 11:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-thAtl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:52 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)) 11:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-KuCzDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:52 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)) 11:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-zp9_JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:52 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)) 11:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-2T8B3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-P9iSBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-k6N9x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-oYmxU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-yU20so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:53 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)) 11:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-4diANA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:53 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)) 11:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-dOr_O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:53 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)) 11:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-YKyot6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:53 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)) 11:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-xKwH6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:53 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)) 11:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-RdKCnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:53 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)) 11:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-TbmRlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:54 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-BE_iU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:54 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-C42zwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:54 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-CMNuwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 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)) 11:09:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:09:54 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 11:09:54 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 11:09:54 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 11:09:54 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 11:09:54 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 11:09:54 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 11:09:56 INFO - Downloading blessings-1.6.tar.gz 11:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:09:56 INFO - Installing collected packages: blessings 11:09:56 INFO - Running setup.py install for blessings 11:09:56 INFO - Successfully installed blessings 11:09:56 INFO - Cleaning up... 11:09:56 INFO - Return code: 0 11:09:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:57 INFO - Reading from file tmpfile_stdout 11:09:57 INFO - Current package versions: 11:09:57 INFO - blessings == 1.6 11:09:57 INFO - blobuploader == 1.2.4 11:09:57 INFO - docopt == 0.6.1 11:09:57 INFO - manifestparser == 1.1 11:09:57 INFO - mozInstall == 1.12 11:09:57 INFO - mozcrash == 0.16 11:09:57 INFO - mozdebug == 0.1 11:09:57 INFO - mozdevice == 0.48 11:09:57 INFO - mozfile == 1.2 11:09:57 INFO - mozhttpd == 0.7 11:09:57 INFO - mozinfo == 0.9 11:09:57 INFO - mozleak == 0.1 11:09:57 INFO - mozlog == 3.1 11:09:57 INFO - moznetwork == 0.27 11:09:57 INFO - mozprocess == 0.22 11:09:57 INFO - mozprofile == 0.28 11:09:57 INFO - mozrunner == 6.11 11:09:57 INFO - mozscreenshot == 0.1 11:09:57 INFO - mozsystemmonitor == 0.0 11:09:57 INFO - moztest == 0.7 11:09:57 INFO - mozversion == 1.4 11:09:57 INFO - psutil == 3.1.1 11:09:57 INFO - requests == 1.2.3 11:09:57 INFO - wsgiref == 0.1.2 11:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dcfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dd64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb704b42b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c73d30>, '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 0x104a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ab20>, '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.RSUyABnMPP/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.fmzXxmJFNK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 11:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RSUyABnMPP/Render', 11:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:57 INFO - 'HOME': '/Users/cltbld', 11:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:57 INFO - 'LOGNAME': 'cltbld', 11:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:57 INFO - 'MOZ_NO_REMOTE': '1', 11:09:57 INFO - 'NO_EM_RESTART': '1', 11:09:57 INFO - 'PAGER': '/bin/cat', 11:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:57 INFO - 'PWD': '/builds/slave/test', 11:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:57 INFO - 'SHELL': '/bin/bash', 11:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmzXxmJFNK/Listeners', 11:09:57 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 11:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:57 INFO - 'USER': 'cltbld', 11:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:57 INFO - 'XPC_FLAGS': '0x0', 11:09:57 INFO - 'XPC_SERVICE_NAME': '0', 11:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:57 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)) 11:09:57 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)) 11:09:57 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)) 11:09:57 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)) 11:09:57 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)) 11:09:57 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)) 11:09:57 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)) 11:09:57 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)) 11:09:57 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)) 11:09:57 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)) 11:09:57 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)) 11:09:57 INFO - Cleaning up... 11:09:57 INFO - Return code: 0 11:09:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:57 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 0x104dcfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dd64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb704b42b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c73d30>, '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 0x104a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ab20>, '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.RSUyABnMPP/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.fmzXxmJFNK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 11:09:57 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 11:09:57 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 11:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RSUyABnMPP/Render', 11:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:57 INFO - 'HOME': '/Users/cltbld', 11:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:57 INFO - 'LOGNAME': 'cltbld', 11:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:57 INFO - 'MOZ_NO_REMOTE': '1', 11:09:57 INFO - 'NO_EM_RESTART': '1', 11:09:57 INFO - 'PAGER': '/bin/cat', 11:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:57 INFO - 'PWD': '/builds/slave/test', 11:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:57 INFO - 'SHELL': '/bin/bash', 11:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmzXxmJFNK/Listeners', 11:09:57 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 11:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:57 INFO - 'USER': 'cltbld', 11:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:57 INFO - 'XPC_FLAGS': '0x0', 11:09:57 INFO - 'XPC_SERVICE_NAME': '0', 11:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:57 INFO - Downloading/unpacking jsonschema 11:09:57 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 11:09:57 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 11:09:57 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 11:09:57 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 11:09:57 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 11:09:57 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 11:10:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:10:00 INFO - Downloading/unpacking functools32 (from jsonschema) 11:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:10:00 INFO - warning: no files found matching '*.txt' 11:10:00 INFO - no previously-included directories found matching 'build' 11:10:00 INFO - no previously-included directories found matching 'dist' 11:10:00 INFO - no previously-included directories found matching '.git*' 11:10:00 INFO - Installing collected packages: jsonschema, functools32 11:10:00 INFO - Running setup.py install for functools32 11:10:00 INFO - warning: no files found matching '*.txt' 11:10:00 INFO - no previously-included directories found matching 'build' 11:10:00 INFO - no previously-included directories found matching 'dist' 11:10:00 INFO - no previously-included directories found matching '.git*' 11:10:00 INFO - Successfully installed jsonschema functools32 11:10:00 INFO - Cleaning up... 11:10:00 INFO - Return code: 0 11:10:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:10:00 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')]} 11:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:00 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')]} 11:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:00 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 0x104dcfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dd64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb704b42b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c73d30>, '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 0x104a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ab20>, '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.RSUyABnMPP/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.fmzXxmJFNK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 11:10:00 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 11:10:00 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 11:10:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RSUyABnMPP/Render', 11:10:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:00 INFO - 'HOME': '/Users/cltbld', 11:10:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:00 INFO - 'LOGNAME': 'cltbld', 11:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:00 INFO - 'MOZ_NO_REMOTE': '1', 11:10:00 INFO - 'NO_EM_RESTART': '1', 11:10:00 INFO - 'PAGER': '/bin/cat', 11:10:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:00 INFO - 'PWD': '/builds/slave/test', 11:10:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:00 INFO - 'SHELL': '/bin/bash', 11:10:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmzXxmJFNK/Listeners', 11:10:00 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 11:10:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:00 INFO - 'USER': 'cltbld', 11:10:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:00 INFO - 'XPC_FLAGS': '0x0', 11:10:00 INFO - 'XPC_SERVICE_NAME': '0', 11:10:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:01 INFO - Downloading/unpacking flake8 11:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:10:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:10:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 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 11:10:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:10:04 INFO - no previously-included directories found matching 'docs/_build' 11:10:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:10:04 INFO - Running setup.py install for pep8 11:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:10:04 INFO - no previously-included directories found matching 'docs/_build' 11:10:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:10:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:10:04 INFO - Cleaning up... 11:10:04 INFO - Return code: 0 11:10:04 INFO - Running post-action listener: _resource_record_post_action 11:10:04 INFO - Running post-action listener: _start_resource_monitoring 11:10:04 INFO - Starting resource monitoring. 11:10:04 INFO - ##### 11:10:04 INFO - ##### Running install step. 11:10:04 INFO - ##### 11:10:04 INFO - Running pre-action listener: _resource_record_pre_action 11:10:04 INFO - Running main action method: install 11:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:10:05 INFO - Reading from file tmpfile_stdout 11:10:05 INFO - Detecting whether we're running mozinstall >=1.0... 11:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:10:05 INFO - Reading from file tmpfile_stdout 11:10:05 INFO - Output received: 11:10:05 INFO - Usage: mozinstall [options] installer 11:10:05 INFO - Options: 11:10:05 INFO - -h, --help show this help message and exit 11:10:05 INFO - -d DEST, --destination=DEST 11:10:05 INFO - Directory to install application into. [default: 11:10:05 INFO - "/builds/slave/test"] 11:10:05 INFO - --app=APP Application being installed. [default: firefox] 11:10:05 INFO - mkdir: /builds/slave/test/build/application 11:10:05 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'] 11:10:05 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 11:10:39 INFO - Reading from file tmpfile_stdout 11:10:39 INFO - Output received: 11:10:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:10:39 INFO - Running post-action listener: _resource_record_post_action 11:10:39 INFO - ##### 11:10:39 INFO - ##### Running run-tests step. 11:10:39 INFO - ##### 11:10:39 INFO - Running pre-action listener: _resource_record_pre_action 11:10:39 INFO - Running main action method: run_tests 11:10:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:10:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:10:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:10:39 INFO - 2016-02-09 11:10:39.087 screenresolution[2314:16964] starting screenresolution argv=screenresolution get 11:10:39 INFO - 2016-02-09 11:10:39.089 screenresolution[2314:16964] Display 0: 1600x1200x32@60 11:10:39 INFO - 2016-02-09 11:10:39.094 screenresolution[2315:16967] starting screenresolution argv=screenresolution list 11:10:39 INFO - Available Modes on Display 0 11:10:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:10:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:10:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:10:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:10:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:10:39 INFO - Intel Iris: 11:10:39 INFO - Chipset Model: Intel Iris 11:10:39 INFO - Type: GPU 11:10:39 INFO - Bus: Built-In 11:10:39 INFO - VRAM (Dynamic, Max): 1536 MB 11:10:39 INFO - Vendor: Intel (0x8086) 11:10:39 INFO - Device ID: 0x0a2e 11:10:39 INFO - Revision ID: 0x0009 11:10:39 INFO - Displays: 11:10:39 INFO - Display: 11:10:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:10:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:10:39 INFO - Display Serial Number: 1600x1200 60 11:10:39 INFO - Main Display: Yes 11:10:39 INFO - Mirror: Off 11:10:39 INFO - Online: Yes 11:10:39 INFO - Rotation: Supported 11:10:39 INFO - Return code: 0 11:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:10:39 INFO - Python 2.7.3 11:10:39 INFO - Return code: 0 11:10:39 INFO - grabbing minidump binary from tooltool 11:10: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')]} 11:10:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c73d30>, '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 0x104a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:10:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:10:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:10:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:10:39 INFO - Return code: 0 11:10:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:10:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:10:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:10:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:10:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:10:40 INFO - Return code: 0 11:10:40 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/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0154', '--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 11:10:40 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/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0154 --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 11:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RSUyABnMPP/Render', 11:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:40 INFO - 'HOME': '/Users/cltbld', 11:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:40 INFO - 'LOGNAME': 'cltbld', 11:10:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:10:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:40 INFO - 'MOZ_NO_REMOTE': '1', 11:10:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:10:40 INFO - 'NO_EM_RESTART': '1', 11:10:40 INFO - 'PAGER': '/bin/cat', 11:10:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:40 INFO - 'PWD': '/builds/slave/test', 11:10:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:40 INFO - 'SHELL': '/bin/bash', 11:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmzXxmJFNK/Listeners', 11:10:40 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 11:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:40 INFO - 'USER': 'cltbld', 11:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:40 INFO - 'XPC_FLAGS': '0x0', 11:10:40 INFO - 'XPC_SERVICE_NAME': '0', 11:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:10:40 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/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0154', '--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 11:10:40 INFO - mozversion application_buildid: 20160209083856 11:10:40 INFO - mozversion application_changeset: 9799df240b379e461fd1ea9dedea3bbe7dfb9631 11:10:40 INFO - mozversion application_display_name: Nightly 11:10:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:10:40 INFO - mozversion application_name: Firefox 11:10:40 INFO - mozversion application_remotingname: firefox 11:10:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:10:40 INFO - mozversion application_vendor: Mozilla 11:10:40 INFO - mozversion application_version: 47.0a1 11:10:40 INFO - mozversion platform_buildid: 20160209083856 11:10:40 INFO - mozversion platform_changeset: 9799df240b379e461fd1ea9dedea3bbe7dfb9631 11:10:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:10:40 INFO - mozversion platform_version: 47.0a1 11:10:40 INFO - using testdate: 1455045040 11:10:40 INFO - actual date: 1455045040 11:10:40 INFO - starting webserver on 'localhost:49990' 11:10:40 INFO - SUITE-START | Running 2 tests 11:10:40 INFO - TEST-START | dromaeo_css 11:10:40 INFO - operating with platform_type : mac_ 11:10:40 INFO - Initialising browser for dromaeo_css test... 11:10:40 INFO - TEST-INFO | started process 2333 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpFioKme/profile http://localhost:49990/getInfo.html) 11:10:43 INFO - PROCESS | 2333 | __metrics Screen width/height:1600/1200 11:10:43 INFO - PROCESS | 2333 | colorDepth:24 11:10:43 INFO - PROCESS | 2333 | Browser inner width/height: 1024/689 11:10:43 INFO - PROCESS | 2333 | __metrics 11:10:43 INFO - PROCESS | 2333 | 11:10:43 INFO - PROCESS | 2333 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 11:10:43 INFO - PROCESS | 2333 | 11:10:44 INFO - TEST-INFO | 2333: exit 0 11:10:44 INFO - Browser initialized. 11:10:44 INFO - Running cycle 1/1 for dromaeo_css test... 11:10:44 INFO - TEST-INFO | started process 2337 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpFioKme/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:56 INFO - PROCESS | 2337 | RSS: Main: 258674688 11:10:56 INFO - PROCESS | 2337 | 11:11:45 INFO - PROCESS | 2337 | 1455045105780 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] 11:13:56 INFO - PROCESS | 2337 | Cycle 1(1): loaded http://localhost:49990/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49990/tests/dromaeo/cssquery-ext.html) 11:13:57 INFO - PROCESS | 2337 | RSS: Main: 271147008 11:13:57 INFO - PROCESS | 2337 | 11:16:59 INFO - PROCESS | 2337 | Cycle 1(1): loaded http://localhost:49990/tests/dromaeo/cssquery-ext.html (next: http://localhost:49990/tests/dromaeo/cssquery-jquery.html) 11:17:00 INFO - PROCESS | 2337 | RSS: Main: 283246592 11:17:00 INFO - PROCESS | 2337 | 11:20:02 INFO - PROCESS | 2337 | Cycle 1(1): loaded http://localhost:49990/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49990/tests/dromaeo/cssquery-mootools.html) 11:20:02 INFO - PROCESS | 2337 | RSS: Main: 285487104 11:20:02 INFO - PROCESS | 2337 | 11:23:04 INFO - PROCESS | 2337 | Cycle 1(1): loaded http://localhost:49990/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49990/tests/dromaeo/cssquery-prototype.html) 11:23:05 INFO - PROCESS | 2337 | RSS: Main: 287158272 11:23:05 INFO - PROCESS | 2337 | 11:26:07 INFO - PROCESS | 2337 | Cycle 1(1): loaded http://localhost:49990/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49990/tests/dromaeo/cssquery-yui.html) 11:26:08 INFO - PROCESS | 2337 | RSS: Main: 288464896 11:26:08 INFO - PROCESS | 2337 | 11:29:10 INFO - PROCESS | 2337 | Cycle 1(1): loaded http://localhost:49990/tests/dromaeo/cssquery-yui.html (next: http://localhost:49990/tests/dromaeo/cssquery-dojo.html) 11:29:10 INFO - PROCESS | 2337 | RSS: Main: 291397632 11:29:10 INFO - PROCESS | 2337 | 11:29:10 INFO - PROCESS | 2337 | __start_tp_report 11:29:10 INFO - PROCESS | 2337 | _x_x_mozilla_page_load 11:29:10 INFO - PROCESS | 2337 | _x_x_mozilla_page_load_details 11:29:10 INFO - PROCESS | 2337 | |i|pagename|runs| 11:29:10 INFO - PROCESS | 2337 | |0;dojo.html;3518.9120271993197;3544.273423948091;3563.3051554946796;3613.7470377073614;3640.6359364063587;5836.620619659724;5877.3241077276125;5885.470307672309;5888;5888.852778680535;4433.179861725583;5749.310082790061;5944.138099975501;5979.611325263855;6056.515478761699;4619.769011549426;4652.604528615072;5176.66351687141;5298.09932311507;5403.432639572848;5386.084365657847;5399.298091248133;5434.021876062327;5450.04624190767;5514.062609356419;5211.5830733541225;5263;5345.1714984177515;5387.73061346935;5407.864803379907;4375.649948004184;5069.670471419383;5276.841694749163;5359.2497050412585;5406.810761623325;4982.82560110398;5302.973485132588;5324.946750532523;5325.281087053237;5336.359636843565;4840.854774356775;5056.584156436167;5732.885342293131;5834.5040671542965;5859.8535036624;6203.875922481525;6258.624482531062;6262.624242545462;6274.309825919146;6274.654893980829;6197.597156184834;6229.595076320024;6273.404026617464;6282.748690052393;6294.150289710922;5999.970000150015;6044.607100538451;6045.21412216409;6045.546584006217;6101.420365065312;5785.363610002896;6232.719527621268;6348.523860710465;6399.424051835264;6399.776007839703;6177.166082578884;6246.500279977591;6259.530535209878;6277.937220627735;6304.148939893147;5266.368035835724;6241.282252541016;6250.404271093065;6283.02613094971;6296.181496405438;6127.92262824669;6175.814725558151;6220;6256.499480041677;6276.874462510816;5544.168374743821;5951.315598706117;6246.875062498724;6257.530685198537;6269.46709529686;4300.290452075373;4830;5044.218146187347;5051.090803655304;5094.847154585368;4443.2224360736745;4448.777561121931;4474.32885067236;4501.3022981437925;4550.112728018071;5923.348431672513;6011.158437818709;6022.307434645072;6058.1215723719815;6058.4244496772735;6152.292486364126;6233.96883015582;6304.464120549713;6304.621722696653;6349.14286571307;5993.580449368589;6039.456448919531;6039.456448919618;6043.123747056652;6056.515478761688;5515.117581187071;5531.032069387841;5537.224788529609;5539.9169012464845;5546.528545073714;6265.122882796412;6388.776392826228;6463.385978332051;6467.579607325509;6484.773032943825;6263.68681565929;6297.4647154992335;6297.811065668037;6298.779542715983;6309.9588567885785;6268.1851359323;6428.742850285937;6431.5819471734185;6440.677966101583;6463.870722585616;6151.6001459904965;6258.280297765815;6260.593061450991;6265.185525881606;6269.874602508015;6240.251169859646;6271.62370257786;6272.74909003653;6300.59046161998;6312.4634406074165;6105.206323177958;6118.816435506942;6159.291681456511;6212.316645168938;6266.624002559861;6235.095911092957;6245.781397651061;6272.8118156455375;6288.496920246278;6299.338569450142;4655.580997710223;6141.631502109888;6178.1659475971965;6208.1308616792785;6212.223472065992;4789.3294938709305;5231.424543300158;5394.865128371822;6059.303180134341;6242.094896239929;6141.263048434216;6154.907676384768;6156.569040167145;6176.722047507783;6191.7523299069335 11:29:10 INFO - PROCESS | 2337 | |1;ext.html;450.86248694148287;469.8613908896873;489.811422602298;509.3454910440085;558.8714595643005;34474.13814654635;36151;36786.63213367866;36860.26279474409;36983.445248321295;37442.43836342457;38294.234115317675;38343.23313533728;38422.03944901379;38468.61531384685;9338.159565639075;9490.383125096881;9565;9580.568874400635;9603.759906002337;9420.81158376832;9549.37929034614;9569.856452153223;9647.807043859118;9707.660231891885;9628.374155679858;9631.518424078804;9683.41899486033;9740.123388894997;9744.464054477;9569.712908612682;9599.184069354113;9653.22774178064;9678.75803104921;9689.224862011022;9435.150836424755;9501.812273465817;9582.520873956344;9613.759656008586;9632.988536203668;31007.534886976715;36788.44817327742;36975.5209791608;37092.88721338364;37252.696155634425;3042.5015903307835;3273.918152046194;3485.6165821759587;3674.3018826423163;3774.150816066363;27008.594871076948;27352.863235683893;27886.860565697243;28030.018949336674;28572.714272857214;2497.700275966896;2795.077624383948;2858.342581206334;2870.9138725838257;2993.1469531183725;404037;406536;406780;407473;407965;54545;64062.03906941399;64414;65759.67120164368;65895;62820.68589657023;62982;63124;63127.6843615779;63439.682801585695;15899.364025438854;15947.20263986796;16106.919465402598;16127.193640317937;16151.35394584227;12199.878001219875;12241.143119981694;12254.509819607294;12284.692882678004;12477.376131193403;17960.101994900204;20120;20576.279830205873;20632.793672063388;20802.375928722162;8156.265936065783;8357.038940521796;8427.662893484192;8924.598393072327;9010.63957441708;915.3455279475207;993.9353941993747;1053.4048262731533;1083.8916108389255;1098.906592939593;28464.861405543546;28934;29361.265968350534;29367.85316073406;29475.968341107957;1056.5140035583563;1119.7872404243167;1128.7403897103711;1130.8021096308114;1139.447368026523;13965.930170349286;14151.85848141526;14152.584741525765;14177.22025288619;14225.78661320081;644031;646966;649264;652625.7368713126;655557;45291.320630190574;55112.0710775121;55734;55768.721156393956;55885;1423.6298562373856;1444.4799872046055;1444.6893917807722;1456.1845366594741;1462.181178540021;27833;27844.860775695994;30782.38435231238;31175.37649246957;32346.514802277514;54222;54601.72699136479;54861.451385485634;54876.72561637166;54962.450375497334;507743;508937;510116;510550;511624;34348.878134623;40666.9833254171;41829.954251143965;41967;43345.34981975336;33369.99890003304;40650.390244146955;40875.7956210217;42525.14949700927;42643.7206883794;34630.653693462744;34769.65230347664;35453;35717.642823571434;35756.4636530447;34269;34852.825735871156;35284.294314114086;35425.82287088548;35430;35792.92621221368;35852.10369740777;35890.92327230187;35953.64046359608;36111.819440902626;30334.393312134074;32152;32183.839080804446;32338;32377.838110809294;21561.598496097704;23263.664154062397;24837.50324993526;25303.36741581475;25311 11:29:10 INFO - PROCESS | 2337 | |2;jquery.html;331.25593748911973;360.7348598779896;363.26257696875336;367.5185506985848;370.1468115992636;15242.237888105607;18949.905250473763;19219.519512012208;19445.90277048613;20011.19955201792;16902.661946761058;18121;18947.715784263248;19192.616147677072;19256.51858703533;5691.715414229293;5833.504152147073;5886.999210134288;5894.764209431618;6007.309159446654;5593.776248950057;5886.558508111909;5961.37405572413;5969.761209551612;5984.281886173665;5364.758585863626;5899.734511946973;5921.082232254007;6534.901976470357;6537.967310163466;6178.5366097542865;6453.967730161343;6476.0933469314095;6530.706118224692;6531.804045878631;5559.833205003856;5597.132444471114;5625.296837895263;5656.349519805234;5671.06427439472;20117;23879.403014924766;24537.263882083567;24739.62890556625;25062.749372506223;2243.9887800561055;2262.6266666000092;2383.475635360218;2413.9517209655883;2899.7245261700314;14278.64303392413;14769.33537990793;14811.333489992976;15013.924930375279;15152.545423637308;1765.7527946087557;1785.9373672664744;1826.9543261418437;1838.1911958738112;1838.8712790104698;90629.54685226598;91784.54107729485;92397.53801231018;92456.53771731099;94215.52892235495;8426.747197584082;8901.73294801157;10359;10780.191485638608;10813.459327033774;12762.936185319015;12808.423620936894;12860.742785144244;12867.42096605655;12887.677808054874;8475.237228649452;8519.275861551714;8600.967883853853;8607.397482176188;8641.438306510057;8598.742037738877;8705;8818.559072046372;8851.513166775889;8946.507942063248;6160.260768707783;6272.968635156886;6287.151234583364;6310.747570097236;6503.122078519434;1508.7402019313995;1519.073195788876;1704.9744253836202;1851.3890416162635;1869.05612665603;790.7232468635931;954.4368822394821;1015.0610685116238;1015.6343716262139;1063.4363787192801;19305.903470482557;19909.10409031597;20134.395968120978;20845.374638760863;20891.79108208929;963.8265112279717;974.541965276319;985.4579981010415;987.3976874106789;1055.984160237597;11119.388433636228;11333.43332833355;11352.659420217407;11358.943205284086;11412.714682133013;582647;597764;608236;613292;683157;115015;118243.67903444366;118466.4076679611;119346;120457.79542204642;1166.177844619558;1202.386782740791;1216.3674889057818;1218.1229514749366;1220.8280051150816;18541.629167416846;18637.90681046586;18735.969521676438;18765.061746912874;18891.716624250374;48347.274790878866;49600.51198464052;49878.012198779834;50151.74924125356;50273.24590131078;65336.67331663311;67381;70724.62037534562;70933;71388.28611713817;7482.663280152515;7844.843103137791;7860.4104692147175;7863.41024423182;7907.48601340911;8006.359491240571;8484;8491.660333586835;8677.913220867711;8752.737417877473;7692.115406728298;7701.614919254127;7729.879167520566;7878.72424465141;7893.447458677838;7673.34776544;7757.1079325878245;7828.647710852912;7931.881021784793;8007.079185893696;7503.73736919227;7614.2766437188375;7885.802854928673;7957.482763620346;8154;11066.170037247399;11232.943835281098;11275.154363422613;11282.435878205893;11474.196806223485;7531;7937.761867143995;8035.758927232192;8039.959800200962;8059.314958228381 11:29:10 INFO - PROCESS | 2337 | |3;mootools.html;1397.769368054271;1535.3167840311062;1751.4045224623626;1907.9809201907976;1915.1956178405069;7989.840203195947;8565.743027709179;8711.43375680581;8902.554872256394;8941.597628106734;8634.611442485088;8676.696315628955;8766.868496972551;8777;8803.77990550235;2462.212092130519;2489.141246270043;2500.8499490030567;2507.034791605236;2523.911663091792;2480.9751902481016;2549.8087643426816;2550.2859199424097;2555.4505781257026;2555.578329575627;2160.9891950540305;2435.1842132885504;2476.4923190745853;2494.5135698538793;2503.173952595648;2445.645381419693;2459.2499287717237;2460.753924607543;2464.1375518568357;2475.7029156501244;2453.852768833876;2464.2484042367073;2475.2697954103583;2480.8015358771254;2482.726900040994;8702.56487175645;8709;8734.956325218396;8762.649494020232;8781.692640757543;5253.579713622901;5422.864428389283;5452.345718513764;5484.287042684426;5486.506214440679;3598.676119149289;3667.5598928128798;3722.925541489155;3731.5149030626117;3738.6635202831603;1031.8400647899587;1053.8313869780875;1057.0909018244304;1086.2070688397434;1087.8912108789057;11844.703882402922;12020.978216851578;12067.57763478274;12081.758364832654;12114.575989840401;4895.290182923456;4942.9752851236235;4987.052460032654;4988.326575912205;5015.799368025311;10336.534855931352;10359.430231337348;10409.583616655249;10411.791764164675;10414.739631509121;5369.6509726867625;5463.262459567987;5480.013597552399;5525.861853453615;5531.806386776443;4897.755112244374;4925.507449255046;4944.876378090505;4948.727819969936;4990.226514890125;3870.0518372998795;3873.1866308075055;3898.4542164097047;3913.412988051758;3914.373700207953;1237.5359240284893;1256.0328547018744;1291.0446269760498;1312.9803052954214;1313.5468263449095;1114.4149321606221;1117.3351855645878;1144.2447984330468;1316.0787448785889;1384.9376778044812;7961.761147165595;8037.397195210383;8101.189881011969;8193.918060819435;8211.8357632847;626.2922897126218;635.6376865186799;644.127207633659;646.3181343682367;792.7621713485931;5604.887902241932;5814.622049566765;6088.634681919099;6273.278572964076;6301.8109456716375;9371.48456834867;10387.584496620051;10547.208959328082;10561.102306303897;10803.081738052197;10766.192535559865;10790.406527641055;10805;10892.727681808019;10987.121030317716;8266.380021498291;8375.120612335617;8390.538520381315;8424.873626895602;8480.321574274167;6906.516543841883;7791;7930.36557075421;8003.6398362075015;8033.959830200812;9441.622335106518;9625.470599117116;9634;9709.951450242703;9725.367851089657;9799.706008819747;10063.547140378554;10115.59537618487;10137.341072830242;10167.084962353423;7512.737054203077;7542.622868856645;7567.054118235221;7592.088949325896;7598.8100297493;7909;8023.799405014921;8109.10799812032;8115.4319197655595;8195.549244791593;7017.473689473208;7641.503302285334;7798.6490607923915;7830.882536761839;7844.333231675371;7606.163322034682;7613.505122167041;7650.540967541965;7742.845143097219;7769.611519424119;7738.458307918617;7759.495632783851;7765.0681918170185;7770;7787.143414224544;6847.349501797321;6999.790006299819;7022;7041.647917603997;7067.081279433641;7141.750038748619;7147.892781608384;7162.89255661155;7176.820579485555;7212.026376439323 11:29:10 INFO - PROCESS | 2337 | |4;prototype.html;325.90874555124566;331.5259179373495;333.9332133573286;337.2378424760043;341.53721707086913;6641.900371494419;6871;6974.442044636429;7007.894881576774;7018.4736144789085;6926.376626103663;6964.303569643033;6965.442764578835;6983.02237686723;6995.090638217037;5188.195829646411;5190.532852043315;5191.896162076756;5198.246254293134;5205.765740541666;4229.450171477703;4906.754662266891;5175.58595312376;5178.378594568657;5192.818251361203;4998.925016124761;4999.700017998914;5008.3238762767105;5017.247412888059;5018.2974383586325;4978.402591688984;4998.975210081924;5013.874653133665;5018.573421259197;5030.8239211627415;4235.089455766994;4236.237477254093;4250.659947204216;4257.510386305584;4269.274223382033;6044.788432404845;6214.130021796952;6616.569922954993;6660.300668429842;6667.4996876171435;5935;5942;5945.097568777993;5956.136360227786;5956.493698035672;7358.190599034102;7371.336579707852;7379.88930166048;7387.224341444178;7389;3678.6505281998434;4595;4704.458987216445;4729;4737.336772851803;7754.7673569793;7874.60626968655;7919.7228097016905;7923.841523169562;7935.523868567847;4778.689385189951;4785.138675038526;4787.952120478821;4793.640476964241;4815.686980346336;4762.59517940972;4854.854354369375;4881.414230292387;4908.141075311806;4914.33656456381;5930.169776231331;5933.406659334119;5935.43613356739;5947.345791962881;5951.434613711691;5321.441248668834;5791.797287094932;7426.814329641694;7446.25537446251;7482.551046937092;1646.2509558151012;1671.5236157694999;1697.414392034746;1699.609089909303;1702.7275635898197;1069.315637991686;1082.5182793656747;1084.1272775415707;1086.9021788039115;1093.4150229627112;5859.941400586024;6992.405645520188;6999.475039371966;7017.193022802341;7050.365467107985;7672.309492145734;7693.730719424793;7695.923040769632;7731.420143489261;7746.18665040174;6807.047013418125;6976.441884649216;6981.232064472904;6983.2318444971015;7081.433485321162;4085.71400001997;4092.202020606013;4094.28350038742;4103.507579090528;4129.15352352767;6607.768728094494;8091.352691784643;8116.797080073045;8123.83752324962;8162.18378162179;7773.961130194313;8058.1538938411795;8069.556174410463;8082.949216601804;8112.513249205066;7603.9619801900635;8095.676172953016;8106.5946702665815;8125.4718443301;8142.7557173284895;7351.772730679773;7516.173220945582;7700.961495192488;7774.2614451627005;7813.4530582860925;7572.318491335586;7627.885581716389;7650.961745191238;7655.50239234448;7666.271704188093;7179;7398.705226585434;8089.716859909875;8118.431709780495;8165.673373065011;4760.976195119002;4824.469308376146;4824.614030877591;4829.323894654822;4847.95152048475;7701.6534255957495;7707.11368192665;7709.344705699854;7714.807129821799;7727.92272077272;7107.431405487652;7360.595167265852;7401.259874012556;7414.66634001482;7433.219511951167;7364.343022819823;7386.778396648109;7400.444966627632;7401.7039318428815;7414.22150674193;7209.747658831916;7211.5480736549825;7223.711051557879;7230.240824713329;7255.419566434778;7133.500654954103;7395.038644976119;7422.220666829905;7422.814429639302;7457.403407727477;7257.455690823103;7257.891131633135;7259.455540834353;7263.4915555910575;7290.234525374759 11:29:10 INFO - PROCESS | 2337 | |5;yui.html;645.609406309183;672.1262358933386;713.1157364867565;724.8260417499802;726.5785844210359;15046.924765376172;15127.986475771606;15376.692466150671;15412.30644620992;15427.768583471243;14041.50854720085;14531.055481393701;14570.490032848853;14578.635534111652;14607.926960365183;683.9110915580992;835.9582020898946;852.4033176776251;852.9616167272487;853.1127627267634;698.8043347862581;846.0777752250046;856.5289090999956;868.374770165483;870.3907264914585;908.1145882764318;916.7983043730369;922.1608336413865;924.8705181274627;924.9953750231273;901.2834796336928;909.822584596004;911.1207684584375;911.5852287209303;912.9954350228239;641.1184621145925;658.9967050164719;668.0680450771196;670.0652589637428;670.2191946382459;14968.925155374154;15118.622034449118;15124.395024199019;15130.848691513054;15192.088474691554;12873.806892896613;12952.417141228667;12963.611091667264;12977.221366718028;13117.081804273705;10026.448545330004;10162.237832162617;10185.134263587604;10518.894811051945;10839;3525.5064290999026;3558.181618227822;3558.288342331544;3561.056320075182;3579.176789338441;79585.20414795836;80738.19261807365;80902.38195236062;80951.99999999942;81146;9659.758506037264;9667.274954378308;9776.36453630526;9876.35803672759;10201.030902064293;20600.690989635168;20840.687389689167;20884.060217290258;20892.791072089083;21782.346529604136;7303.3792127668685;7459.552426854406;7463.664135113824;7484;7615.657295421719;4145.046639272984;4155.459790227251;4164.958350416457;4168.2080404723;4204.936925946114;3519.542459480251;3555.093451169935;3581.086822860206;3586.6951309138494;3595.532580764484;651.0787236060921;653.3368630839701;653.8005908198045;676.100785954679;679.5005670831935;550.7163810637525;617.783775678509;623.7754408412968;625.8122563231012;628.6196850905228;8038.959805200937;8463.28062114727;8759.69341073072;9256.305777066747;9335.766605834773;513.1225604216756;576.7145263094795;586.3932824062124;590.3712546138435;628.8616504369031;4084.8366065357054;4088.897777555585;4114.650254728382;4115.8765237042935;4121.402396652528;85696.57151714327;94744.52627736818;96227.51886240524;101560;102862;59159.816803664544;70872.2912770876;78471.60764196143;84158;85206.57396712976;66812.66593667;67273.3272667267;67508;68997.2750681237;69903;6836.316368363124;7958.124606293419;8085.83828323442;8213.219744124537;8357.331413486785;44504.10991780211;45275.868103296365;48968.26547601718;49599.00801984012;50701;67422;67453.66273168602;68880.6555967217;69552;69740;10996.560137594726;11231.775364492501;11267.380294083576;11584.536618535165;12004.699882502659;11606.24559403636;12041.638750837488;12370.876291236973;12451.937740311603;12664.620061398173;11146.275492092987;11600.187986841178;11991.940040299743;12023.519059237533;12427.565035223724;11592.942035289769;11676.532938682358;12084.577039803564;12202.694932626755;12254.080943929419;11248.156388270749;11392.316461012366;11581.015613672933;11581.768364632828;12420.62738117858;9292.860607090764;9413.199878010446;9514.762130946781;9904.405735655884;10447.164226861682;8152.516453074002;8443.691227859692;8932.374733768575;9303.395279306824;9999.800003999733 11:29:10 INFO - PROCESS | 2337 | __end_tp_report 11:29:10 INFO - PROCESS | 2337 | __start_cc_report 11:29:10 INFO - PROCESS | 2337 | _x_x_mozilla_cycle_collect,380 11:29:10 INFO - PROCESS | 2337 | __end_cc_report 11:29:10 INFO - PROCESS | 2337 | __startTimestamp1455046150744__endTimestamp 11:29:10 INFO - PROCESS | 2337 | 11:29:10 INFO - PROCESS | 2337 | ------- Summary: start ------- 11:29:10 INFO - PROCESS | 2337 | Number of tests: 6 11:29:10 INFO - PROCESS | 2337 | 11:29:10 INFO - PROCESS | 2337 | [#0] dojo.html Cycles:165 Average:5785.74 Median:6059.30 stddev:673.86 (11.1%) stddev-sans-first:652.04 11:29:10 INFO - PROCESS | 2337 | Values: 3518.9 3544.3 3563.3 3613.7 3640.6 5836.6 5877.3 5885.5 5888.0 5888.9 4433.2 5749.3 5944.1 5979.6 6056.5 4619.8 4652.6 5176.7 5298.1 5403.4 5386.1 5399.3 5434.0 5450.0 5514.1 5211.6 5263.0 5345.2 5387.7 5407.9 4375.6 5069.7 5276.8 5359.2 5406.8 4982.8 5303.0 5324.9 5325.3 5336.4 4840.9 5056.6 5732.9 5834.5 5859.9 6203.9 6258.6 6262.6 6274.3 6274.7 6197.6 6229.6 6273.4 6282.7 6294.2 6000.0 6044.6 6045.2 6045.5 6101.4 5785.4 6232.7 6348.5 6399.4 6399.8 6177.2 6246.5 6259.5 6277.9 6304.1 5266.4 6241.3 6250.4 6283.0 6296.2 6127.9 6175.8 6220.0 6256.5 6276.9 5544.2 5951.3 6246.9 6257.5 6269.5 4300.3 4830.0 5044.2 5051.1 5094.8 4443.2 4448.8 4474.3 4501.3 4550.1 5923.3 6011.2 6022.3 6058.1 6058.4 6152.3 6234.0 6304.5 6304.6 6349.1 5993.6 6039.5 6039.5 6043.1 6056.5 5515.1 5531.0 5537.2 5539.9 5546.5 6265.1 6388.8 6463.4 6467.6 6484.8 6263.7 6297.5 6297.8 6298.8 6310.0 6268.2 6428.7 6431.6 6440.7 6463.9 6151.6 6258.3 6260.6 6265.2 6269.9 6240.3 6271.6 6272.7 6300.6 6312.5 6105.2 6118.8 6159.3 6212.3 6266.6 6235.1 6245.8 6272.8 6288.5 6299.3 4655.6 6141.6 6178.2 6208.1 6212.2 4789.3 5231.4 5394.9 6059.3 6242.1 6141.3 6154.9 6156.6 6176.7 6191.8 11:29:10 INFO - PROCESS | 2337 | 11:29:10 INFO - PROCESS | 2337 | [#1] ext.html Cycles:180 Average:65819.07 Median:36979.48 stddev:142007.66 (384.0%) stddev-sans-first:142321.22 11:29:10 INFO - PROCESS | 2337 | Values: 450.9 469.9 489.8 509.3 558.9 34474.1 36151.0 36786.6 36860.3 36983.4 37442.4 38294.2 38343.2 38422.0 38468.6 9338.2 9490.4 9565.0 9580.6 9603.8 9420.8 9549.4 9569.9 9647.8 9707.7 9628.4 9631.5 9683.4 9740.1 9744.5 9569.7 9599.2 9653.2 9678.8 9689.2 9435.2 9501.8 9582.5 9613.8 9633.0 31007.5 36788.4 36975.5 37092.9 37252.7 3042.5 3273.9 3485.6 3674.3 3774.2 27008.6 27352.9 27886.9 28030.0 28572.7 2497.7 2795.1 2858.3 2870.9 2993.1 404037.0 406536.0 406780.0 407473.0 407965.0 54545.0 64062.0 64414.0 65759.7 65895.0 62820.7 62982.0 63124.0 63127.7 63439.7 15899.4 15947.2 16106.9 16127.2 16151.4 12199.9 12241.1 12254.5 12284.7 12477.4 17960.1 20120.0 20576.3 20632.8 20802.4 8156.3 8357.0 8427.7 8924.6 9010.6 915.3 993.9 1053.4 1083.9 1098.9 28464.9 28934.0 29361.3 29367.9 29476.0 1056.5 1119.8 1128.7 1130.8 1139.4 13965.9 14151.9 14152.6 14177.2 14225.8 644031.0 646966.0 649264.0 652625.7 655557.0 45291.3 55112.1 55734.0 55768.7 55885.0 1423.6 1444.5 1444.7 1456.2 1462.2 27833.0 27844.9 30782.4 31175.4 32346.5 54222.0 54601.7 54861.5 54876.7 54962.5 507743.0 508937.0 510116.0 510550.0 511624.0 34348.9 40667.0 41830.0 41967.0 43345.3 33370.0 40650.4 40875.8 42525.1 42643.7 34630.7 34769.7 35453.0 35717.6 35756.5 34269.0 34852.8 35284.3 35425.8 35430.0 35792.9 35852.1 35890.9 35953.6 36111.8 30334.4 32152.0 32183.8 32338.0 32377.8 21561.6 23263.7 24837.5 25303.4 25311.0 11:29:10 INFO - PROCESS | 2337 | 11:29:10 INFO - PROCESS | 2337 | [#2] jquery.html Cycles:180 Average:33799.32 Median:5611.21 stddev:102220.73 (1821.7%) stddev-sans-first:102476.60 11:29:10 INFO - PROCESS | 2337 | Values: 331.3 360.7 363.3 367.5 370.1 15242.2 18949.9 19219.5 19445.9 20011.2 16902.7 18121.0 18947.7 19192.6 19256.5 5691.7 5833.5 5887.0 5894.8 6007.3 5593.8 5886.6 5961.4 5969.8 5984.3 5364.8 5899.7 5921.1 6534.9 6538.0 6178.5 6454.0 6476.1 6530.7 6531.8 5559.8 5597.1 5625.3 5656.3 5671.1 20117.0 23879.4 24537.3 24739.6 25062.7 2244.0 2262.6 2383.5 2414.0 2899.7 14278.6 14769.3 14811.3 15013.9 15152.5 1765.8 1785.9 1827.0 1838.2 1838.9 90629.5 91784.5 92397.5 92456.5 94215.5 8426.7 8901.7 10359.0 10780.2 10813.5 12762.9 12808.4 12860.7 12867.4 12887.7 8475.2 8519.3 8601.0 8607.4 8641.4 8598.7 8705.0 8818.6 8851.5 8946.5 6160.3 6273.0 6287.2 6310.7 6503.1 1508.7 1519.1 1705.0 1851.4 1869.1 790.7 954.4 1015.1 1015.6 1063.4 19305.9 19909.1 20134.4 20845.4 20891.8 963.8 974.5 985.5 987.4 1056.0 11119.4 11333.4 11352.7 11358.9 11412.7 582647.0 597764.0 608236.0 613292.0 683157.0 115015.0 118243.7 118466.4 119346.0 120457.8 1166.2 1202.4 1216.4 1218.1 1220.8 18541.6 18637.9 18736.0 18765.1 18891.7 48347.3 49600.5 49878.0 50151.7 50273.2 65336.7 67381.0 70724.6 70933.0 71388.3 7482.7 7844.8 7860.4 7863.4 7907.5 8006.4 8484.0 8491.7 8677.9 8752.7 7692.1 7701.6 7729.9 7878.7 7893.4 7673.3 7757.1 7828.6 7931.9 8007.1 7503.7 7614.3 7885.8 7957.5 8154.0 11066.2 11232.9 11275.2 11282.4 11474.2 7531.0 7937.8 8035.8 8040.0 8059.3 11:29:10 INFO - PROCESS | 2337 | 11:29:10 INFO - PROCESS | 2337 | [#3] mootools.html Cycles:180 Average:6088.16 Median:5437.61 stddev:3222.45 (59.3%) stddev-sans-first:3212.20 11:29:10 INFO - PROCESS | 2337 | Values: 1397.8 1535.3 1751.4 1908.0 1915.2 7989.8 8565.7 8711.4 8902.6 8941.6 8634.6 8676.7 8766.9 8777.0 8803.8 2462.2 2489.1 2500.8 2507.0 2523.9 2481.0 2549.8 2550.3 2555.5 2555.6 2161.0 2435.2 2476.5 2494.5 2503.2 2445.6 2459.2 2460.8 2464.1 2475.7 2453.9 2464.2 2475.3 2480.8 2482.7 8702.6 8709.0 8735.0 8762.6 8781.7 5253.6 5422.9 5452.3 5484.3 5486.5 3598.7 3667.6 3722.9 3731.5 3738.7 1031.8 1053.8 1057.1 1086.2 1087.9 11844.7 12021.0 12067.6 12081.8 12114.6 4895.3 4943.0 4987.1 4988.3 5015.8 10336.5 10359.4 10409.6 10411.8 10414.7 5369.7 5463.3 5480.0 5525.9 5531.8 4897.8 4925.5 4944.9 4948.7 4990.2 3870.1 3873.2 3898.5 3913.4 3914.4 1237.5 1256.0 1291.0 1313.0 1313.5 1114.4 1117.3 1144.2 1316.1 1384.9 7961.8 8037.4 8101.2 8193.9 8211.8 626.3 635.6 644.1 646.3 792.8 5604.9 5814.6 6088.6 6273.3 6301.8 9371.5 10387.6 10547.2 10561.1 10803.1 10766.2 10790.4 10805.0 10892.7 10987.1 8266.4 8375.1 8390.5 8424.9 8480.3 6906.5 7791.0 7930.4 8003.6 8034.0 9441.6 9625.5 9634.0 9710.0 9725.4 9799.7 10063.5 10115.6 10137.3 10167.1 7512.7 7542.6 7567.1 7592.1 7598.8 7909.0 8023.8 8109.1 8115.4 8195.5 7017.5 7641.5 7798.6 7830.9 7844.3 7606.2 7613.5 7650.5 7742.8 7769.6 7738.5 7759.5 7765.1 7770.0 7787.1 6847.3 6999.8 7022.0 7041.6 7067.1 7141.8 7147.9 7162.9 7176.8 7212.0 11:29:10 INFO - PROCESS | 2337 | 11:29:10 INFO - PROCESS | 2337 | [#4] prototype.html Cycles:180 Average:6038.54 Median:6975.44 stddev:1962.24 (28.1%) stddev-sans-first:1920.32 11:29:10 INFO - PROCESS | 2337 | Values: 325.9 331.5 333.9 337.2 341.5 6641.9 6871.0 6974.4 7007.9 7018.5 6926.4 6964.3 6965.4 6983.0 6995.1 5188.2 5190.5 5191.9 5198.2 5205.8 4229.5 4906.8 5175.6 5178.4 5192.8 4998.9 4999.7 5008.3 5017.2 5018.3 4978.4 4999.0 5013.9 5018.6 5030.8 4235.1 4236.2 4250.7 4257.5 4269.3 6044.8 6214.1 6616.6 6660.3 6667.5 5935.0 5942.0 5945.1 5956.1 5956.5 7358.2 7371.3 7379.9 7387.2 7389.0 3678.7 4595.0 4704.5 4729.0 4737.3 7754.8 7874.6 7919.7 7923.8 7935.5 4778.7 4785.1 4788.0 4793.6 4815.7 4762.6 4854.9 4881.4 4908.1 4914.3 5930.2 5933.4 5935.4 5947.3 5951.4 5321.4 5791.8 7426.8 7446.3 7482.6 1646.3 1671.5 1697.4 1699.6 1702.7 1069.3 1082.5 1084.1 1086.9 1093.4 5859.9 6992.4 6999.5 7017.2 7050.4 7672.3 7693.7 7695.9 7731.4 7746.2 6807.0 6976.4 6981.2 6983.2 7081.4 4085.7 4092.2 4094.3 4103.5 4129.2 6607.8 8091.4 8116.8 8123.8 8162.2 7774.0 8058.2 8069.6 8082.9 8112.5 7604.0 8095.7 8106.6 8125.5 8142.8 7351.8 7516.2 7701.0 7774.3 7813.5 7572.3 7627.9 7651.0 7655.5 7666.3 7179.0 7398.7 8089.7 8118.4 8165.7 4761.0 4824.5 4824.6 4829.3 4848.0 7701.7 7707.1 7709.3 7714.8 7727.9 7107.4 7360.6 7401.3 7414.7 7433.2 7364.3 7386.8 7400.4 7401.7 7414.2 7209.7 7211.5 7223.7 7230.2 7255.4 7133.5 7395.0 7422.2 7422.8 7457.4 7257.5 7257.9 7259.5 7263.5 7290.2 11:29:10 INFO - PROCESS | 2337 | 11:29:10 INFO - PROCESS | 2337 | [#5] yui.html Cycles:180 Average:18332.22 Median:620.78 stddev:25765.68 (4150.5%) stddev-sans-first:25803.73 11:29:10 INFO - PROCESS | 2337 | Values: 645.6 672.1 713.1 724.8 726.6 15046.9 15128.0 15376.7 15412.3 15427.8 14041.5 14531.1 14570.5 14578.6 14607.9 683.9 836.0 852.4 853.0 853.1 698.8 846.1 856.5 868.4 870.4 908.1 916.8 922.2 924.9 925.0 901.3 909.8 911.1 911.6 913.0 641.1 659.0 668.1 670.1 670.2 14968.9 15118.6 15124.4 15130.8 15192.1 12873.8 12952.4 12963.6 12977.2 13117.1 10026.4 10162.2 10185.1 10518.9 10839.0 3525.5 3558.2 3558.3 3561.1 3579.2 79585.2 80738.2 80902.4 80952.0 81146.0 9659.8 9667.3 9776.4 9876.4 10201.0 20600.7 20840.7 20884.1 20892.8 21782.3 7303.4 7459.6 7463.7 7484.0 7615.7 4145.0 4155.5 4165.0 4168.2 4204.9 3519.5 3555.1 3581.1 3586.7 3595.5 651.1 653.3 653.8 676.1 679.5 550.7 617.8 623.8 625.8 628.6 8039.0 8463.3 8759.7 9256.3 9335.8 513.1 576.7 586.4 590.4 628.9 4084.8 4088.9 4114.7 4115.9 4121.4 85696.6 94744.5 96227.5 101560.0 102862.0 59159.8 70872.3 78471.6 84158.0 85206.6 66812.7 67273.3 67508.0 68997.3 69903.0 6836.3 7958.1 8085.8 8213.2 8357.3 44504.1 45275.9 48968.3 49599.0 50701.0 67422.0 67453.7 68880.7 69552.0 69740.0 10996.6 11231.8 11267.4 11584.5 12004.7 11606.2 12041.6 12370.9 12451.9 12664.6 11146.3 11600.2 11991.9 12023.5 12427.6 11592.9 11676.5 12084.6 12202.7 12254.1 11248.2 11392.3 11581.0 11581.8 12420.6 9292.9 9413.2 9514.8 9904.4 10447.2 8152.5 8443.7 8932.4 9303.4 9999.8 11:29:10 INFO - PROCESS | 2337 | -------- Summary: end -------- 11:29:10 INFO - PROCESS | 2337 | 11:29:11 INFO - TEST-INFO | 2337: exit 0 11:29:11 INFO - TEST-OK | dromaeo_css | took 1110342ms 11:29:11 INFO - TEST-START | kraken 11:29:11 INFO - operating with platform_type : mac_ 11:29:11 INFO - Initialising browser for kraken test... 11:29:11 INFO - TEST-INFO | started process 2342 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmph3rd37/profile http://localhost:49990/getInfo.html) 11:29:13 INFO - PROCESS | 2342 | __metrics Screen width/height:1600/1200 11:29:13 INFO - PROCESS | 2342 | colorDepth:24 11:29:13 INFO - PROCESS | 2342 | Browser inner width/height: 1024/689 11:29:13 INFO - PROCESS | 2342 | __metrics 11:29:14 INFO - PROCESS | 2342 | 11:29:14 INFO - PROCESS | 2342 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 11:29:14 INFO - PROCESS | 2342 | 11:29:14 INFO - TEST-INFO | 2342: exit 0 11:29:14 INFO - Browser initialized. 11:29:14 INFO - Running cycle 1/1 for kraken test... 11:29:14 INFO - TEST-INFO | started process 2345 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmph3rd37/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:29:26 INFO - PROCESS | 2345 | RSS: Main: 258748416 11:29:26 INFO - PROCESS | 2345 | 11:29:29 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49990/tests/kraken/driver.html?testName=audio-beat-detection) 11:29:30 INFO - PROCESS | 2345 | RSS: Main: 271044608 11:29:30 INFO - PROCESS | 2345 | 11:29:32 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49990/tests/kraken/driver.html?testName=audio-dft) 11:29:33 INFO - PROCESS | 2345 | RSS: Main: 280264704 11:29:33 INFO - PROCESS | 2345 | 11:29:36 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49990/tests/kraken/driver.html?testName=audio-fft) 11:29:37 INFO - PROCESS | 2345 | RSS: Main: 283279360 11:29:37 INFO - PROCESS | 2345 | 11:29:39 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49990/tests/kraken/driver.html?testName=audio-oscillator) 11:29:39 INFO - PROCESS | 2345 | RSS: Main: 284299264 11:29:39 INFO - PROCESS | 2345 | 11:29:41 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49990/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:29:42 INFO - PROCESS | 2345 | RSS: Main: 284598272 11:29:42 INFO - PROCESS | 2345 | 11:29:45 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49990/tests/kraken/driver.html?testName=imaging-darkroom) 11:29:45 INFO - PROCESS | 2345 | RSS: Main: 284217344 11:29:45 INFO - PROCESS | 2345 | 11:29:48 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49990/tests/kraken/driver.html?testName=imaging-desaturate) 11:29:49 INFO - PROCESS | 2345 | RSS: Main: 284139520 11:29:49 INFO - PROCESS | 2345 | 11:29:52 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49990/tests/kraken/driver.html?testName=json-parse-financial) 11:29:53 INFO - PROCESS | 2345 | RSS: Main: 285589504 11:29:53 INFO - PROCESS | 2345 | 11:29:54 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49990/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:29:55 INFO - PROCESS | 2345 | RSS: Main: 285958144 11:29:55 INFO - PROCESS | 2345 | 11:29:57 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49990/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:29:57 INFO - PROCESS | 2345 | RSS: Main: 284303360 11:29:57 INFO - PROCESS | 2345 | 11:29:59 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49990/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:30:00 INFO - PROCESS | 2345 | RSS: Main: 284286976 11:30:00 INFO - PROCESS | 2345 | 11:30:03 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49990/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:30:03 INFO - PROCESS | 2345 | RSS: Main: 286101504 11:30:03 INFO - PROCESS | 2345 | 11:30:06 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49990/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:30:06 INFO - PROCESS | 2345 | RSS: Main: 285081600 11:30:06 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | Cycle 1(1): loaded http://localhost:49990/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49990/tests/kraken/driver.html?testName=ai-astar) 11:30:08 INFO - PROCESS | 2345 | RSS: Main: 286830592 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | __start_tp_report 11:30:08 INFO - PROCESS | 2345 | _x_x_mozilla_page_load 11:30:08 INFO - PROCESS | 2345 | _x_x_mozilla_page_load_details 11:30:08 INFO - PROCESS | 2345 | |i|pagename|runs| 11:30:08 INFO - PROCESS | 2345 | |0;ai-astar;115;108;114;138;170;162;114;113;114;115 11:30:08 INFO - PROCESS | 2345 | |1;audio-beat-detection;151;122;142;154;121;142;139;119;155;123 11:30:08 INFO - PROCESS | 2345 | |2;audio-dft;191;198;199;201;204;218;197;199;279;240 11:30:08 INFO - PROCESS | 2345 | |3;audio-fft;69;71;72;122;84;60;59;60;130;74 11:30:08 INFO - PROCESS | 2345 | |4;audio-oscillator;81;98;125;89;118;120;119;81;83;116 11:30:08 INFO - PROCESS | 2345 | |5;imaging-gaussian-blur;89;92;85;92;86;91;89;94;85;91 11:30:08 INFO - PROCESS | 2345 | |6;imaging-darkroom;140;123;96;95;94;94;96;94;96;95 11:30:08 INFO - PROCESS | 2345 | |7;imaging-desaturate;91;101;91;137;86;107;147;146;90;130 11:30:08 INFO - PROCESS | 2345 | |8;json-parse-financial;55;57;57;54;57;55;56;68;68;83 11:30:08 INFO - PROCESS | 2345 | |9;json-stringify-tinderbox;66;77;92;68;75;102;98;96;93;83 11:30:08 INFO - PROCESS | 2345 | |10;stanford-crypto-aes;83;85;84;87;96;83;86;85;84;83 11:30:08 INFO - PROCESS | 2345 | |11;stanford-crypto-ccm;127;130;132;125;134;131;135;116;129;129 11:30:08 INFO - PROCESS | 2345 | |12;stanford-crypto-pbkdf2;139;138;144;140;143;143;144;141;146;131 11:30:08 INFO - PROCESS | 2345 | |13;stanford-crypto-sha256-iterative;70;70;67;68;71;69;67;68;67;69 11:30:08 INFO - PROCESS | 2345 | __end_tp_report 11:30:08 INFO - PROCESS | 2345 | __start_cc_report 11:30:08 INFO - PROCESS | 2345 | _x_x_mozilla_cycle_collect,923 11:30:08 INFO - PROCESS | 2345 | __end_cc_report 11:30:08 INFO - PROCESS | 2345 | __startTimestamp1455046208663__endTimestamp 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | ------- Summary: start ------- 11:30:08 INFO - PROCESS | 2345 | Number of tests: 14 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#0] ai-astar Cycles:10 Average:126.30 Median:115.00 stddev:22.47 (19.5%) stddev-sans-first:23.45 11:30:08 INFO - PROCESS | 2345 | Values: 115.0 108.0 114.0 138.0 170.0 162.0 114.0 113.0 114.0 115.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:142.00 stddev:14.39 (10.1%) stddev-sans-first:14.32 11:30:08 INFO - PROCESS | 2345 | Values: 151.0 122.0 142.0 154.0 121.0 142.0 139.0 119.0 155.0 123.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#2] audio-dft Cycles:10 Average:212.60 Median:202.50 stddev:27.26 (13.5%) stddev-sans-first:27.78 11:30:08 INFO - PROCESS | 2345 | Values: 191.0 198.0 199.0 201.0 204.0 218.0 197.0 199.0 279.0 240.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#3] audio-fft Cycles:10 Average:80.10 Median:70.00 stddev:25.44 (36.3%) stddev-sans-first:26.66 11:30:08 INFO - PROCESS | 2345 | Values: 69.0 71.0 72.0 122.0 84.0 60.0 59.0 60.0 130.0 74.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:81.00 stddev:18.29 (22.6%) stddev-sans-first:17.59 11:30:08 INFO - PROCESS | 2345 | Values: 81.0 98.0 125.0 89.0 118.0 120.0 119.0 81.0 83.0 116.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:91.00 stddev:3.17 (3.5%) stddev-sans-first:3.36 11:30:08 INFO - PROCESS | 2345 | Values: 89.0 92.0 85.0 92.0 86.0 91.0 89.0 94.0 85.0 91.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#6] imaging-darkroom Cycles:10 Average:102.30 Median:95.00 stddev:15.92 (16.8%) stddev-sans-first:9.37 11:30:08 INFO - PROCESS | 2345 | Values: 140.0 123.0 96.0 95.0 94.0 94.0 96.0 94.0 96.0 95.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#7] imaging-desaturate Cycles:10 Average:112.60 Median:116.50 stddev:24.75 (21.2%) stddev-sans-first:24.99 11:30:08 INFO - PROCESS | 2345 | Values: 91.0 101.0 91.0 137.0 86.0 107.0 147.0 146.0 90.0 130.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:57.00 stddev:9.29 (16.3%) stddev-sans-first:9.59 11:30:08 INFO - PROCESS | 2345 | Values: 55.0 57.0 57.0 54.0 57.0 55.0 56.0 68.0 68.0 83.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#9] json-stringify-tinderbox Cycles:10 Average:85.00 Median:87.50 stddev:12.95 (14.8%) stddev-sans-first:11.77 11:30:08 INFO - PROCESS | 2345 | Values: 66.0 77.0 92.0 68.0 75.0 102.0 98.0 96.0 93.0 83.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:3.89 (4.6%) stddev-sans-first:4.01 11:30:08 INFO - PROCESS | 2345 | Values: 83.0 85.0 84.0 87.0 96.0 83.0 86.0 85.0 84.0 83.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:130.50 stddev:5.41 (4.1%) stddev-sans-first:5.70 11:30:08 INFO - PROCESS | 2345 | Values: 127.0 130.0 132.0 125.0 134.0 131.0 135.0 116.0 129.0 129.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.90 Median:143.00 stddev:4.28 (3.0%) stddev-sans-first:4.48 11:30:08 INFO - PROCESS | 2345 | Values: 139.0 138.0 144.0 140.0 143.0 143.0 144.0 141.0 146.0 131.0 11:30:08 INFO - PROCESS | 2345 | 11:30:08 INFO - PROCESS | 2345 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.43 (2.1%) stddev-sans-first:1.42 11:30:08 INFO - PROCESS | 2345 | Values: 70.0 70.0 67.0 68.0 71.0 69.0 67.0 68.0 67.0 69.0 11:30:08 INFO - PROCESS | 2345 | -------- Summary: end -------- 11:30:08 INFO - PROCESS | 2345 | 11:30:09 INFO - TEST-INFO | 2345: exit 0 11:30:09 INFO - TEST-OK | kraken | took 58115ms 11:30:09 INFO - SUITE-END | took 1168s 11:30:09 INFO - Completed test suite (00:19:28) 11:30:09 INFO - Working with test: dromaeo_css 11:30:09 INFO - Generating results file: dromaeo_css 11:30:09 INFO - Working with test: kraken 11:30:09 INFO - Generating results file: kraken 11:30:09 INFO - javascript benchmark 11:30:09 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:30:09 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 11:30:09 INFO - process_Request line: dromaeo_css 7571.60 graph.html#tests=[[72,64,61]] 11:30:09 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:30:10 INFO - process_Request line: kraken 1533.00 graph.html#tests=[[232,64,61]] 11:30:10 INFO - RETURN: dromaeo_css: 7571.60 11:30:10 INFO - RETURN: kraken: 1533.00 11:30:10 INFO - javascript benchmark 11:30:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3518.9120271993197, 3544.273423948091, 3563.3051554946796, 3613.7470377073614, 3640.6359364063587, 5836.620619659724, 5877.3241077276125, 5885.470307672309, 5888.0, 5888.852778680535, 4433.179861725583, 5749.310082790061, 5944.138099975501, 5979.611325263855, 6056.515478761699, 4619.769011549426, 4652.604528615072, 5176.66351687141, 5298.09932311507, 5403.432639572848, 5386.084365657847, 5399.298091248133, 5434.021876062327, 5450.04624190767, 5514.062609356419, 5211.5830733541225, 5263.0, 5345.1714984177515, 5387.73061346935, 5407.864803379907, 4375.649948004184, 5069.670471419383, 5276.841694749163, 5359.2497050412585, 5406.810761623325, 4982.82560110398, 5302.973485132588, 5324.946750532523, 5325.281087053237, 5336.359636843565, 4840.854774356775, 5056.584156436167, 5732.885342293131, 5834.5040671542965, 5859.8535036624, 6203.875922481525, 6258.624482531062, 6262.624242545462, 6274.309825919146, 6274.654893980829, 6197.597156184834, 6229.595076320024, 6273.404026617464, 6282.748690052393, 6294.150289710922, 5999.970000150015, 6044.607100538451, 6045.21412216409, 6045.546584006217, 6101.420365065312, 5785.363610002896, 6232.719527621268, 6348.523860710465, 6399.424051835264, 6399.776007839703, 6177.166082578884, 6246.500279977591, 6259.530535209878, 6277.937220627735, 6304.148939893147, 5266.368035835724, 6241.282252541016, 6250.404271093065, 6283.02613094971, 6296.181496405438, 6127.92262824669, 6175.814725558151, 6220.0, 6256.499480041677, 6276.874462510816, 5544.168374743821, 5951.315598706117, 6246.875062498724, 6257.530685198537, 6269.46709529686, 4300.290452075373, 4830.0, 5044.218146187347, 5051.090803655304, 5094.847154585368, 4443.2224360736745, 4448.777561121931, 4474.32885067236, 4501.3022981437925, 4550.112728018071, 5923.348431672513, 6011.158437818709, 6022.307434645072, 6058.1215723719815, 6058.4244496772735, 6152.292486364126, 6233.96883015582, 6304.464120549713, 6304.621722696653, 6349.14286571307, 5993.580449368589, 6039.456448919531, 6039.456448919618, 6043.123747056652, 6056.515478761688, 5515.117581187071, 5531.032069387841, 5537.224788529609, 5539.9169012464845, 5546.528545073714, 6265.122882796412, 6388.776392826228, 6463.385978332051, 6467.579607325509, 6484.773032943825, 6263.68681565929, 6297.4647154992335, 6297.811065668037, 6298.779542715983, 6309.9588567885785, 6268.1851359323, 6428.742850285937, 6431.5819471734185, 6440.677966101583, 6463.870722585616, 6151.6001459904965, 6258.280297765815, 6260.593061450991, 6265.185525881606, 6269.874602508015, 6240.251169859646, 6271.62370257786, 6272.74909003653, 6300.59046161998, 6312.4634406074165, 6105.206323177958, 6118.816435506942, 6159.291681456511, 6212.316645168938, 6266.624002559861, 6235.095911092957, 6245.781397651061, 6272.8118156455375, 6288.496920246278, 6299.338569450142, 4655.580997710223, 6141.631502109888, 6178.1659475971965, 6208.1308616792785, 6212.223472065992, 4789.3294938709305, 5231.424543300158, 5394.865128371822, 6059.303180134341, 6242.094896239929, 6141.263048434216, 6154.907676384768, 6156.569040167145, 6176.722047507783, 6191.7523299069335], "unit": "score", "name": "dojo.html", "value": 5746.341572808906}, {"lowerIsBetter": false, "replicates": [450.86248694148287, 469.8613908896873, 489.811422602298, 509.3454910440085, 558.8714595643005, 34474.13814654635, 36151.0, 36786.63213367866, 36860.26279474409, 36983.445248321295, 37442.43836342457, 38294.234115317675, 38343.23313533728, 38422.03944901379, 38468.61531384685, 9338.159565639075, 9490.383125096881, 9565.0, 9580.568874400635, 9603.759906002337, 9420.81158376832, 9549.37929034614, 9569.856452153223, 9647.807043859118, 9707.660231891885, 9628.374155679858, 9631.518424078804, 9683.41899486033, 9740.123388894997, 9744.464054477, 9569.712908612682, 9599.184069354113, 9653.22774178064, 9678.75803104921, 9689.224862011022, 9435.150836424755, 9501.812273465817, 9582.520873956344, 9613.759656008586, 9632.988536203668, 31007.534886976715, 36788.44817327742, 36975.5209791608, 37092.88721338364, 37252.696155634425, 3042.5015903307835, 3273.918152046194, 3485.6165821759587, 3674.3018826423163, 3774.150816066363, 27008.594871076948, 27352.863235683893, 27886.860565697243, 28030.018949336674, 28572.714272857214, 2497.700275966896, 2795.077624383948, 2858.342581206334, 2870.9138725838257, 2993.1469531183725, 404037.0, 406536.0, 406780.0, 407473.0, 407965.0, 54545.0, 64062.03906941399, 64414.0, 65759.67120164368, 65895.0, 62820.68589657023, 62982.0, 63124.0, 63127.6843615779, 63439.682801585695, 15899.364025438854, 15947.20263986796, 16106.919465402598, 16127.193640317937, 16151.35394584227, 12199.878001219875, 12241.143119981694, 12254.509819607294, 12284.692882678004, 12477.376131193403, 17960.101994900204, 20120.0, 20576.279830205873, 20632.793672063388, 20802.375928722162, 8156.265936065783, 8357.038940521796, 8427.662893484192, 8924.598393072327, 9010.63957441708, 915.3455279475207, 993.9353941993747, 1053.4048262731533, 1083.8916108389255, 1098.906592939593, 28464.861405543546, 28934.0, 29361.265968350534, 29367.85316073406, 29475.968341107957, 1056.5140035583563, 1119.7872404243167, 1128.7403897103711, 1130.8021096308114, 1139.447368026523, 13965.930170349286, 14151.85848141526, 14152.584741525765, 14177.22025288619, 14225.78661320081, 644031.0, 646966.0, 649264.0, 652625.7368713126, 655557.0, 45291.320630190574, 55112.0710775121, 55734.0, 55768.721156393956, 55885.0, 1423.6298562373856, 1444.4799872046055, 1444.6893917807722, 1456.1845366594741, 1462.181178540021, 27833.0, 27844.860775695994, 30782.38435231238, 31175.37649246957, 32346.514802277514, 54222.0, 54601.72699136479, 54861.451385485634, 54876.72561637166, 54962.450375497334, 507743.0, 508937.0, 510116.0, 510550.0, 511624.0, 34348.878134623, 40666.9833254171, 41829.954251143965, 41967.0, 43345.34981975336, 33369.99890003304, 40650.390244146955, 40875.7956210217, 42525.14949700927, 42643.7206883794, 34630.653693462744, 34769.65230347664, 35453.0, 35717.642823571434, 35756.4636530447, 34269.0, 34852.825735871156, 35284.294314114086, 35425.82287088548, 35430.0, 35792.92621221368, 35852.10369740777, 35890.92327230187, 35953.64046359608, 36111.819440902626, 30334.393312134074, 32152.0, 32183.839080804446, 32338.0, 32377.838110809294, 21561.598496097704, 23263.664154062397, 24837.50324993526, 25303.36741581475, 25311.0], "unit": "score", "name": "ext.html", "value": 19584.80770724721}, {"lowerIsBetter": false, "replicates": [331.25593748911973, 360.7348598779896, 363.26257696875336, 367.5185506985848, 370.1468115992636, 15242.237888105607, 18949.905250473763, 19219.519512012208, 19445.90277048613, 20011.19955201792, 16902.661946761058, 18121.0, 18947.715784263248, 19192.616147677072, 19256.51858703533, 5691.715414229293, 5833.504152147073, 5886.999210134288, 5894.764209431618, 6007.309159446654, 5593.776248950057, 5886.558508111909, 5961.37405572413, 5969.761209551612, 5984.281886173665, 5364.758585863626, 5899.734511946973, 5921.082232254007, 6534.901976470357, 6537.967310163466, 6178.5366097542865, 6453.967730161343, 6476.0933469314095, 6530.706118224692, 6531.804045878631, 5559.833205003856, 5597.132444471114, 5625.296837895263, 5656.349519805234, 5671.06427439472, 20117.0, 23879.403014924766, 24537.263882083567, 24739.62890556625, 25062.749372506223, 2243.9887800561055, 2262.6266666000092, 2383.475635360218, 2413.9517209655883, 2899.7245261700314, 14278.64303392413, 14769.33537990793, 14811.333489992976, 15013.924930375279, 15152.545423637308, 1765.7527946087557, 1785.9373672664744, 1826.9543261418437, 1838.1911958738112, 1838.8712790104698, 90629.54685226598, 91784.54107729485, 92397.53801231018, 92456.53771731099, 94215.52892235495, 8426.747197584082, 8901.73294801157, 10359.0, 10780.191485638608, 10813.459327033774, 12762.936185319015, 12808.423620936894, 12860.742785144244, 12867.42096605655, 12887.677808054874, 8475.237228649452, 8519.275861551714, 8600.967883853853, 8607.397482176188, 8641.438306510057, 8598.742037738877, 8705.0, 8818.559072046372, 8851.513166775889, 8946.507942063248, 6160.260768707783, 6272.968635156886, 6287.151234583364, 6310.747570097236, 6503.122078519434, 1508.7402019313995, 1519.073195788876, 1704.9744253836202, 1851.3890416162635, 1869.05612665603, 790.7232468635931, 954.4368822394821, 1015.0610685116238, 1015.6343716262139, 1063.4363787192801, 19305.903470482557, 19909.10409031597, 20134.395968120978, 20845.374638760863, 20891.79108208929, 963.8265112279717, 974.541965276319, 985.4579981010415, 987.3976874106789, 1055.984160237597, 11119.388433636228, 11333.43332833355, 11352.659420217407, 11358.943205284086, 11412.714682133013, 582647.0, 597764.0, 608236.0, 613292.0, 683157.0, 115015.0, 118243.67903444366, 118466.4076679611, 119346.0, 120457.79542204642, 1166.177844619558, 1202.386782740791, 1216.3674889057818, 1218.1229514749366, 1220.8280051150816, 18541.629167416846, 18637.90681046586, 18735.969521676438, 18765.061746912874, 18891.716624250374, 48347.274790878866, 49600.51198464052, 49878.012198779834, 50151.74924125356, 50273.24590131078, 65336.67331663311, 67381.0, 70724.62037534562, 70933.0, 71388.28611713817, 7482.663280152515, 7844.843103137791, 7860.4104692147175, 7863.41024423182, 7907.48601340911, 8006.359491240571, 8484.0, 8491.660333586835, 8677.913220867711, 8752.737417877473, 7692.115406728298, 7701.614919254127, 7729.879167520566, 7878.72424465141, 7893.447458677838, 7673.34776544, 7757.1079325878245, 7828.647710852912, 7931.881021784793, 8007.079185893696, 7503.73736919227, 7614.2766437188375, 7885.802854928673, 7957.482763620346, 8154.0, 11066.170037247399, 11232.943835281098, 11275.154363422613, 11282.435878205893, 11474.196806223485, 7531.0, 7937.761867143995, 8035.758927232192, 8039.959800200962, 8059.314958228381], "unit": "score", "name": "jquery.html", "value": 9188.173388499163}, {"lowerIsBetter": false, "replicates": [1397.769368054271, 1535.3167840311062, 1751.4045224623626, 1907.9809201907976, 1915.1956178405069, 7989.840203195947, 8565.743027709179, 8711.43375680581, 8902.554872256394, 8941.597628106734, 8634.611442485088, 8676.696315628955, 8766.868496972551, 8777.0, 8803.77990550235, 2462.212092130519, 2489.141246270043, 2500.8499490030567, 2507.034791605236, 2523.911663091792, 2480.9751902481016, 2549.8087643426816, 2550.2859199424097, 2555.4505781257026, 2555.578329575627, 2160.9891950540305, 2435.1842132885504, 2476.4923190745853, 2494.5135698538793, 2503.173952595648, 2445.645381419693, 2459.2499287717237, 2460.753924607543, 2464.1375518568357, 2475.7029156501244, 2453.852768833876, 2464.2484042367073, 2475.2697954103583, 2480.8015358771254, 2482.726900040994, 8702.56487175645, 8709.0, 8734.956325218396, 8762.649494020232, 8781.692640757543, 5253.579713622901, 5422.864428389283, 5452.345718513764, 5484.287042684426, 5486.506214440679, 3598.676119149289, 3667.5598928128798, 3722.925541489155, 3731.5149030626117, 3738.6635202831603, 1031.8400647899587, 1053.8313869780875, 1057.0909018244304, 1086.2070688397434, 1087.8912108789057, 11844.703882402922, 12020.978216851578, 12067.57763478274, 12081.758364832654, 12114.575989840401, 4895.290182923456, 4942.9752851236235, 4987.052460032654, 4988.326575912205, 5015.799368025311, 10336.534855931352, 10359.430231337348, 10409.583616655249, 10411.791764164675, 10414.739631509121, 5369.6509726867625, 5463.262459567987, 5480.013597552399, 5525.861853453615, 5531.806386776443, 4897.755112244374, 4925.507449255046, 4944.876378090505, 4948.727819969936, 4990.226514890125, 3870.0518372998795, 3873.1866308075055, 3898.4542164097047, 3913.412988051758, 3914.373700207953, 1237.5359240284893, 1256.0328547018744, 1291.0446269760498, 1312.9803052954214, 1313.5468263449095, 1114.4149321606221, 1117.3351855645878, 1144.2447984330468, 1316.0787448785889, 1384.9376778044812, 7961.761147165595, 8037.397195210383, 8101.189881011969, 8193.918060819435, 8211.8357632847, 626.2922897126218, 635.6376865186799, 644.127207633659, 646.3181343682367, 792.7621713485931, 5604.887902241932, 5814.622049566765, 6088.634681919099, 6273.278572964076, 6301.8109456716375, 9371.48456834867, 10387.584496620051, 10547.208959328082, 10561.102306303897, 10803.081738052197, 10766.192535559865, 10790.406527641055, 10805.0, 10892.727681808019, 10987.121030317716, 8266.380021498291, 8375.120612335617, 8390.538520381315, 8424.873626895602, 8480.321574274167, 6906.516543841883, 7791.0, 7930.36557075421, 8003.6398362075015, 8033.959830200812, 9441.622335106518, 9625.470599117116, 9634.0, 9709.951450242703, 9725.367851089657, 9799.706008819747, 10063.547140378554, 10115.59537618487, 10137.341072830242, 10167.084962353423, 7512.737054203077, 7542.622868856645, 7567.054118235221, 7592.088949325896, 7598.8100297493, 7909.0, 8023.799405014921, 8109.10799812032, 8115.4319197655595, 8195.549244791593, 7017.473689473208, 7641.503302285334, 7798.6490607923915, 7830.882536761839, 7844.333231675371, 7606.163322034682, 7613.505122167041, 7650.540967541965, 7742.845143097219, 7769.611519424119, 7738.458307918617, 7759.495632783851, 7765.0681918170185, 7770.0, 7787.143414224544, 6847.349501797321, 6999.790006299819, 7022.0, 7041.647917603997, 7067.081279433641, 7141.750038748619, 7147.892781608384, 7162.89255661155, 7176.820579485555, 7212.026376439323], "unit": "score", "name": "mootools.html", "value": 4903.768569948204}, {"lowerIsBetter": false, "replicates": [325.90874555124566, 331.5259179373495, 333.9332133573286, 337.2378424760043, 341.53721707086913, 6641.900371494419, 6871.0, 6974.442044636429, 7007.894881576774, 7018.4736144789085, 6926.376626103663, 6964.303569643033, 6965.442764578835, 6983.02237686723, 6995.090638217037, 5188.195829646411, 5190.532852043315, 5191.896162076756, 5198.246254293134, 5205.765740541666, 4229.450171477703, 4906.754662266891, 5175.58595312376, 5178.378594568657, 5192.818251361203, 4998.925016124761, 4999.700017998914, 5008.3238762767105, 5017.247412888059, 5018.2974383586325, 4978.402591688984, 4998.975210081924, 5013.874653133665, 5018.573421259197, 5030.8239211627415, 4235.089455766994, 4236.237477254093, 4250.659947204216, 4257.510386305584, 4269.274223382033, 6044.788432404845, 6214.130021796952, 6616.569922954993, 6660.300668429842, 6667.4996876171435, 5935.0, 5942.0, 5945.097568777993, 5956.136360227786, 5956.493698035672, 7358.190599034102, 7371.336579707852, 7379.88930166048, 7387.224341444178, 7389.0, 3678.6505281998434, 4595.0, 4704.458987216445, 4729.0, 4737.336772851803, 7754.7673569793, 7874.60626968655, 7919.7228097016905, 7923.841523169562, 7935.523868567847, 4778.689385189951, 4785.138675038526, 4787.952120478821, 4793.640476964241, 4815.686980346336, 4762.59517940972, 4854.854354369375, 4881.414230292387, 4908.141075311806, 4914.33656456381, 5930.169776231331, 5933.406659334119, 5935.43613356739, 5947.345791962881, 5951.434613711691, 5321.441248668834, 5791.797287094932, 7426.814329641694, 7446.25537446251, 7482.551046937092, 1646.2509558151012, 1671.5236157694999, 1697.414392034746, 1699.609089909303, 1702.7275635898197, 1069.315637991686, 1082.5182793656747, 1084.1272775415707, 1086.9021788039115, 1093.4150229627112, 5859.941400586024, 6992.405645520188, 6999.475039371966, 7017.193022802341, 7050.365467107985, 7672.309492145734, 7693.730719424793, 7695.923040769632, 7731.420143489261, 7746.18665040174, 6807.047013418125, 6976.441884649216, 6981.232064472904, 6983.2318444971015, 7081.433485321162, 4085.71400001997, 4092.202020606013, 4094.28350038742, 4103.507579090528, 4129.15352352767, 6607.768728094494, 8091.352691784643, 8116.797080073045, 8123.83752324962, 8162.18378162179, 7773.961130194313, 8058.1538938411795, 8069.556174410463, 8082.949216601804, 8112.513249205066, 7603.9619801900635, 8095.676172953016, 8106.5946702665815, 8125.4718443301, 8142.7557173284895, 7351.772730679773, 7516.173220945582, 7700.961495192488, 7774.2614451627005, 7813.4530582860925, 7572.318491335586, 7627.885581716389, 7650.961745191238, 7655.50239234448, 7666.271704188093, 7179.0, 7398.705226585434, 8089.716859909875, 8118.431709780495, 8165.673373065011, 4760.976195119002, 4824.469308376146, 4824.614030877591, 4829.323894654822, 4847.95152048475, 7701.6534255957495, 7707.11368192665, 7709.344705699854, 7714.807129821799, 7727.92272077272, 7107.431405487652, 7360.595167265852, 7401.259874012556, 7414.66634001482, 7433.219511951167, 7364.343022819823, 7386.778396648109, 7400.444966627632, 7401.7039318428815, 7414.22150674193, 7209.747658831916, 7211.5480736549825, 7223.711051557879, 7230.240824713329, 7255.419566434778, 7133.500654954103, 7395.038644976119, 7422.220666829905, 7422.814429639302, 7457.403407727477, 7257.455690823103, 7257.891131633135, 7259.455540834353, 7263.4915555910575, 7290.234525374759], "unit": "score", "name": "prototype.html", "value": 5375.955568944679}, {"lowerIsBetter": false, "replicates": [645.609406309183, 672.1262358933386, 713.1157364867565, 724.8260417499802, 726.5785844210359, 15046.924765376172, 15127.986475771606, 15376.692466150671, 15412.30644620992, 15427.768583471243, 14041.50854720085, 14531.055481393701, 14570.490032848853, 14578.635534111652, 14607.926960365183, 683.9110915580992, 835.9582020898946, 852.4033176776251, 852.9616167272487, 853.1127627267634, 698.8043347862581, 846.0777752250046, 856.5289090999956, 868.374770165483, 870.3907264914585, 908.1145882764318, 916.7983043730369, 922.1608336413865, 924.8705181274627, 924.9953750231273, 901.2834796336928, 909.822584596004, 911.1207684584375, 911.5852287209303, 912.9954350228239, 641.1184621145925, 658.9967050164719, 668.0680450771196, 670.0652589637428, 670.2191946382459, 14968.925155374154, 15118.622034449118, 15124.395024199019, 15130.848691513054, 15192.088474691554, 12873.806892896613, 12952.417141228667, 12963.611091667264, 12977.221366718028, 13117.081804273705, 10026.448545330004, 10162.237832162617, 10185.134263587604, 10518.894811051945, 10839.0, 3525.5064290999026, 3558.181618227822, 3558.288342331544, 3561.056320075182, 3579.176789338441, 79585.20414795836, 80738.19261807365, 80902.38195236062, 80951.99999999942, 81146.0, 9659.758506037264, 9667.274954378308, 9776.36453630526, 9876.35803672759, 10201.030902064293, 20600.690989635168, 20840.687389689167, 20884.060217290258, 20892.791072089083, 21782.346529604136, 7303.3792127668685, 7459.552426854406, 7463.664135113824, 7484.0, 7615.657295421719, 4145.046639272984, 4155.459790227251, 4164.958350416457, 4168.2080404723, 4204.936925946114, 3519.542459480251, 3555.093451169935, 3581.086822860206, 3586.6951309138494, 3595.532580764484, 651.0787236060921, 653.3368630839701, 653.8005908198045, 676.100785954679, 679.5005670831935, 550.7163810637525, 617.783775678509, 623.7754408412968, 625.8122563231012, 628.6196850905228, 8038.959805200937, 8463.28062114727, 8759.69341073072, 9256.305777066747, 9335.766605834773, 513.1225604216756, 576.7145263094795, 586.3932824062124, 590.3712546138435, 628.8616504369031, 4084.8366065357054, 4088.897777555585, 4114.650254728382, 4115.8765237042935, 4121.402396652528, 85696.57151714327, 94744.52627736818, 96227.51886240524, 101560.0, 102862.0, 59159.816803664544, 70872.2912770876, 78471.60764196143, 84158.0, 85206.57396712976, 66812.66593667, 67273.3272667267, 67508.0, 68997.2750681237, 69903.0, 6836.316368363124, 7958.124606293419, 8085.83828323442, 8213.219744124537, 8357.331413486785, 44504.10991780211, 45275.868103296365, 48968.26547601718, 49599.00801984012, 50701.0, 67422.0, 67453.66273168602, 68880.6555967217, 69552.0, 69740.0, 10996.560137594726, 11231.775364492501, 11267.380294083576, 11584.536618535165, 12004.699882502659, 11606.24559403636, 12041.638750837488, 12370.876291236973, 12451.937740311603, 12664.620061398173, 11146.275492092987, 11600.187986841178, 11991.940040299743, 12023.519059237533, 12427.565035223724, 11592.942035289769, 11676.532938682358, 12084.577039803564, 12202.694932626755, 12254.080943929419, 11248.156388270749, 11392.316461012366, 11581.015613672933, 11581.768364632828, 12420.62738117858, 9292.860607090764, 9413.199878010446, 9514.762130946781, 9904.405735655884, 10447.164226861682, 8152.516453074002, 8443.691227859692, 8932.374733768575, 9303.395279306824, 9999.800003999733], "unit": "score", "name": "yui.html", "value": 6911.443774963528}], "name": "dromaeo_css", "value": 7571.604121489393}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 114.0, 138.0, 170.0, 162.0, 114.0, 113.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 126.3}, {"lowerIsBetter": true, "replicates": [151.0, 122.0, 142.0, 154.0, 121.0, 142.0, 139.0, 119.0, 155.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 136.8}, {"lowerIsBetter": true, "replicates": [191.0, 198.0, 199.0, 201.0, 204.0, 218.0, 197.0, 199.0, 279.0, 240.0], "unit": "score", "name": "audio-dft", "value": 212.6}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 72.0, 122.0, 84.0, 60.0, 59.0, 60.0, 130.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [81.0, 98.0, 125.0, 89.0, 118.0, 120.0, 119.0, 81.0, 83.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 103.0}, {"lowerIsBetter": true, "replicates": [89.0, 92.0, 85.0, 92.0, 86.0, 91.0, 89.0, 94.0, 85.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.4}, {"lowerIsBetter": true, "replicates": [140.0, 123.0, 96.0, 95.0, 94.0, 94.0, 96.0, 94.0, 96.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 102.3}, {"lowerIsBetter": true, "replicates": [91.0, 101.0, 91.0, 137.0, 86.0, 107.0, 147.0, 146.0, 90.0, 130.0], "unit": "score", "name": "imaging-desaturate", "value": 112.6}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 57.0, 54.0, 57.0, 55.0, 56.0, 68.0, 68.0, 83.0], "unit": "score", "name": "json-parse-financial", "value": 61.0}, {"lowerIsBetter": true, "replicates": [66.0, 77.0, 92.0, 68.0, 75.0, 102.0, 98.0, 96.0, 93.0, 83.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 85.0}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 87.0, 96.0, 83.0, 86.0, 85.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [127.0, 130.0, 132.0, 125.0, 134.0, 131.0, 135.0, 116.0, 129.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.8}, {"lowerIsBetter": true, "replicates": [139.0, 138.0, 144.0, 140.0, 143.0, 143.0, 144.0, 141.0, 146.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.9}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 67.0, 68.0, 71.0, 69.0, 67.0, 68.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1532.9999999999998}]} 11:30:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1533.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7571.60"}}} 11:30:10 INFO - Return code: 0 11:30:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:30:10 INFO - # TBPL SUCCESS # 11:30:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:30:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:30:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:30:10 INFO - 2016-02-09 11:30:10.218 screenresolution[2351:19528] starting screenresolution argv=screenresolution get 11:30:10 INFO - 2016-02-09 11:30:10.221 screenresolution[2351:19528] Display 0: 1600x1200x32@60 11:30:10 INFO - 2016-02-09 11:30:10.227 screenresolution[2352:19531] starting screenresolution argv=screenresolution list 11:30:10 INFO - Available Modes on Display 0 11:30:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:30:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:30:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:30:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:30:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:30:10 INFO - Intel Iris: 11:30:10 INFO - Chipset Model: Intel Iris 11:30:10 INFO - Type: GPU 11:30:10 INFO - Bus: Built-In 11:30:10 INFO - VRAM (Dynamic, Max): 1536 MB 11:30:10 INFO - Vendor: Intel (0x8086) 11:30:10 INFO - Device ID: 0x0a2e 11:30:10 INFO - Revision ID: 0x0009 11:30:10 INFO - Displays: 11:30:10 INFO - Display: 11:30:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:30:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:30:10 INFO - Display Serial Number: 1600x1200 60 11:30:10 INFO - Main Display: Yes 11:30:10 INFO - Mirror: Off 11:30:10 INFO - Online: Yes 11:30:10 INFO - Rotation: Supported 11:30:10 INFO - Return code: 0 11:30:10 INFO - Running post-action listener: _resource_record_post_action 11:30:10 INFO - Running post-run listener: _resource_record_post_run 11:30:11 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 28672; Write bytes: 709655040; Read time: 1; Write time: 2094 11:30:11 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404322816; Write bytes: 406332928; Read time: 30196; Write time: 759 11:30:11 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 28672; Write bytes: 301978624; Read time: 1; Write time: 1331 11:30:11 INFO - Running post-run listener: _upload_blobber_files 11:30:11 INFO - Blob upload gear active. 11:30:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:30:11 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 11:30:11 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'] 11:30:11 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 11:30:11 INFO - (blobuploader) - INFO - Open directory for files ... 11:30:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:30:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:30:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:30:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:12 INFO - (blobuploader) - INFO - Done attempting. 11:30:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:30:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:30:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:30:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:13 INFO - (blobuploader) - INFO - Done attempting. 11:30:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:30:13 INFO - Return code: 0 11:30:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:30:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:30:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2dbb53223ab816e434650f675b6bbb2c336be35eec70f62e0fbd4962449fa47a1c19a751e426a330ed1b6519bc17c4cec837f1f43cee36bc3223c0e09d950818", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47a8241e0861a8eeeda0413baa2e211d9e31b913bb942fa908165e18ac3e86e0a632c7dd8583c97477d26e6412bee70d1106418505abdab9b09ea0daaa00ee08"} 11:30:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:30:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:30:13 INFO - Contents: 11:30:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2dbb53223ab816e434650f675b6bbb2c336be35eec70f62e0fbd4962449fa47a1c19a751e426a330ed1b6519bc17c4cec837f1f43cee36bc3223c0e09d950818", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47a8241e0861a8eeeda0413baa2e211d9e31b913bb942fa908165e18ac3e86e0a632c7dd8583c97477d26e6412bee70d1106418505abdab9b09ea0daaa00ee08"} 11:30:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:30:13 INFO - Copying logs to upload dir... 11:30:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:30:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.631783 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-02-09 11:30:13.937738) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 11:30:13.941567) ========= 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.RSUyABnMPP/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.fmzXxmJFNK/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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/2dbb53223ab816e434650f675b6bbb2c336be35eec70f62e0fbd4962449fa47a1c19a751e426a330ed1b6519bc17c4cec837f1f43cee36bc3223c0e09d950818", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47a8241e0861a8eeeda0413baa2e211d9e31b913bb942fa908165e18ac3e86e0a632c7dd8583c97477d26e6412bee70d1106418505abdab9b09ea0daaa00ee08"} build_url:https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/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/2dbb53223ab816e434650f675b6bbb2c336be35eec70f62e0fbd4962449fa47a1c19a751e426a330ed1b6519bc17c4cec837f1f43cee36bc3223c0e09d950818", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47a8241e0861a8eeeda0413baa2e211d9e31b913bb942fa908165e18ac3e86e0a632c7dd8583c97477d26e6412bee70d1106418505abdab9b09ea0daaa00ee08"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 11:30:13.968260) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:30:13.968584) ========= 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.RSUyABnMPP/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.fmzXxmJFNK/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.005252 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:30:14.017096) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 11:30:14.017443) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 11:30:14.017868) ========= ========= Total master_lag: 0.71 =========