builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0073 starttime: 1455176513.36 results: success (0) buildid: 20160210224431 builduid: 3d3bffa65fca4b75a005def7a4c6188b revision: 0add7cd89394362d9458cc1a9c3a63d8ac4205e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:53.361127) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:53.361688) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:53.361974) ========= 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.hG2r4mfW1l/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.0mQbw35P8O/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.005609 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:53.416119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:53.416429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:53.438513) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:53.438800) ========= 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.hG2r4mfW1l/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.0mQbw35P8O/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.005178 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:53.507662) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:53.507940) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:53.513333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:53.513666) ========= 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.hG2r4mfW1l/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.0mQbw35P8O/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-10 23:41:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.5M=0.001s 2016-02-10 23:41:53 (19.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.467614 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:54.001827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:54.002115) ========= 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.hG2r4mfW1l/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.0mQbw35P8O/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.019428 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:54.051075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-10 23:41:54.051429) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0add7cd89394362d9458cc1a9c3a63d8ac4205e2 --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 0add7cd89394362d9458cc1a9c3a63d8ac4205e2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hG2r4mfW1l/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.0mQbw35P8O/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-10 23:41:54,120 truncating revision to first 12 chars 2016-02-10 23:41:54,120 Setting DEBUG logging. 2016-02-10 23:41:54,120 attempt 1/10 2016-02-10 23:41:54,120 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0add7cd89394?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 23:41:56,087 unpacking tar archive at: fx-team-0add7cd89394/testing/mozharness/ program finished with exit code 0 elapsedTime=2.213401 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-10 23:41:56.280334) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:56.283711) ========= echo 0add7cd89394362d9458cc1a9c3a63d8ac4205e2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0add7cd89394362d9458cc1a9c3a63d8ac4205e2'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hG2r4mfW1l/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.0mQbw35P8O/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 0add7cd89394362d9458cc1a9c3a63d8ac4205e2 program finished with exit code 0 elapsedTime=0.005527 script_repo_revision: '0add7cd89394362d9458cc1a9c3a63d8ac4205e2' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:56.333183) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:56.333645) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 23:41:56.348052) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2016-02-10 23:41:56.348428) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.hG2r4mfW1l/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.0mQbw35P8O/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:41:56 INFO - MultiFileLogger online at 20160210 23:41:56 in /builds/slave/test 23:41:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:41:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:41:56 INFO - {'append_to_log': False, 23:41:56 INFO - 'base_work_dir': '/builds/slave/test', 23:41:56 INFO - 'blob_upload_branch': 'Fx-Team', 23:41:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:41:56 INFO - 'branch': 'Fx-Team', 23:41:56 INFO - 'buildbot_json_path': 'buildprops.json', 23:41:56 INFO - 'config_files': ('talos/mac_config.py',), 23:41:56 INFO - 'default_actions': ('clobber', 23:41:56 INFO - 'read-buildbot-config', 23:41:56 INFO - 'download-and-extract', 23:41:56 INFO - 'populate-webroot', 23:41:56 INFO - 'create-virtualenv', 23:41:56 INFO - 'install', 23:41:56 INFO - 'run-tests'), 23:41:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:41:56 INFO - 'download_minidump_stackwalk': True, 23:41:56 INFO - 'download_symbols': 'ondemand', 23:41:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:41:56 INFO - 'tooltool.py': '/tools/tooltool.py', 23:41:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:41:56 INFO - '/tools/misc-python/virtualenv.py')}, 23:41:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:41:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:41:56 INFO - 'installer_path': 'installer.exe', 23:41:56 INFO - 'log_level': 'info', 23:41:56 INFO - 'log_name': 'talos', 23:41:56 INFO - 'log_to_console': True, 23:41:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:41:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:41:56 INFO - 'opt_config_files': (), 23:41:56 INFO - 'pip_index': False, 23:41:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:41:56 INFO - 'cmd': ('bash', 23:41:56 INFO - '-c', 23:41:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:41:56 INFO - 'enabled': True, 23:41:56 INFO - 'halt_on_failure': False, 23:41:56 INFO - 'name': 'check_screen_resolution'},), 23:41:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:41:56 INFO - 'cmd': ('bash', 23:41:56 INFO - '-c', 23:41:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:41:56 INFO - 'enabled': True, 23:41:56 INFO - 'halt_on_failure': False, 23:41:56 INFO - 'name': 'check_screen_resolution'},), 23:41:56 INFO - 'run_cmd_checks_enabled': True, 23:41:56 INFO - 'sps_profile': False, 23:41:56 INFO - 'sps_profile_interval': 0, 23:41:56 INFO - 'suite': 'dromaeojs', 23:41:56 INFO - 'system_bits': '32', 23:41:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:41:56 INFO - 'title': 't-yosemite-r7-0073', 23:41:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:41:56 INFO - 'use_talos_json': True, 23:41:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:41:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:41:56 INFO - 'work_dir': 'build'} 23:41:56 INFO - ##### 23:41:56 INFO - ##### Running clobber step. 23:41:56 INFO - ##### 23:41:56 INFO - Running pre-action listener: _resource_record_pre_action 23:41:56 INFO - Running main action method: clobber 23:41:56 INFO - rmtree: /builds/slave/test/build 23:41:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:41:56 INFO - Running post-action listener: _resource_record_post_action 23:41:56 INFO - ##### 23:41:56 INFO - ##### Running read-buildbot-config step. 23:41:56 INFO - ##### 23:41:56 INFO - Running pre-action listener: _resource_record_pre_action 23:41:56 INFO - Running main action method: read_buildbot_config 23:41:56 INFO - Using buildbot properties: 23:41:56 INFO - { 23:41:56 INFO - "project": "", 23:41:56 INFO - "product": "firefox", 23:41:56 INFO - "script_repo_revision": "production", 23:41:56 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 23:41:56 INFO - "repository": "", 23:41:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 23:41:56 INFO - "buildid": "20160210224431", 23:41:56 INFO - "pgo_build": "False", 23:41:56 INFO - "basedir": "/builds/slave/test", 23:41:56 INFO - "buildnumber": 329, 23:41:56 INFO - "slavename": "t-yosemite-r7-0073", 23:41:56 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 23:41:56 INFO - "platform": "yosemite_r7", 23:41:56 INFO - "scheduler": "tests-fx-team-macosx64-talos", 23:41:56 INFO - "branch": "fx-team", 23:41:56 INFO - "repo_path": "integration/fx-team", 23:41:56 INFO - "revision": "0add7cd89394362d9458cc1a9c3a63d8ac4205e2", 23:41:56 INFO - "stage_platform": "macosx64", 23:41:56 INFO - "builduid": "3d3bffa65fca4b75a005def7a4c6188b", 23:41:56 INFO - "slavebuilddir": "test" 23:41:56 INFO - } 23:41:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 23:41:56 INFO - Running post-action listener: _resource_record_post_action 23:41:56 INFO - ##### 23:41:56 INFO - ##### Running download-and-extract step. 23:41:56 INFO - ##### 23:41:56 INFO - Running pre-action listener: _resource_record_pre_action 23:41:56 INFO - Running main action method: download_and_extract 23:41:56 INFO - mkdir: /builds/slave/test/build/tests 23:41:56 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')]} 23:41:56 INFO - https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:41:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/test_packages.json 23:41:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/test_packages.json 23:41:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:41:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:42:10 INFO - Downloaded 1277 bytes. 23:42:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:42:10 INFO - Using the following test package requirements: 23:42:10 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 23:42:10 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:42:10 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 23:42:10 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:42:10 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 23:42:10 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:42:10 INFO - u'jsshell-mac.zip'], 23:42:10 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:42:10 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 23:42:10 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 23:42:10 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:42:10 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 23:42:10 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:42:10 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 23:42:10 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:42:10 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 23:42:10 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 23:42:10 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:42:10 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 23:42:10 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:10 INFO - https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:42:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 23:42:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 23:42:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/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 23:42:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/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 23:42:16 INFO - Downloaded 17750525 bytes. 23:42:16 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'] 23:42:16 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 23:42:19 INFO - Return code: 0 23:42:19 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 23:42:19 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')]} 23:42:19 INFO - https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:42:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 23:42:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 23:42:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/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 23:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/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 23:42:25 INFO - Downloaded 17750525 bytes. 23:42:25 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'] 23:42:25 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 23:42:29 INFO - Return code: 0 23:42:29 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')]} 23:42:29 INFO - https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:42:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 23:42:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 23:42:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/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 23:42:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/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 23:42:30 INFO - Downloaded 10706547 bytes. 23:42:30 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'] 23:42:30 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 23:42:30 INFO - Return code: 0 23:42:30 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')]} 23:42:30 INFO - https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:42:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 23:42:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 23:42:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 23:42:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/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 23:42:33 INFO - Downloaded 111187449 bytes. 23:42:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 23:42:33 INFO - mkdir: /builds/slave/test/properties 23:42:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:42:33 INFO - Writing to file /builds/slave/test/properties/build_url 23:42:33 INFO - Contents: 23:42:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 23:42:34 INFO - Running post-action listener: _resource_record_post_action 23:42:34 INFO - Running post-action listener: set_extra_try_arguments 23:42:34 INFO - ##### 23:42:34 INFO - ##### Running populate-webroot step. 23:42:34 INFO - ##### 23:42:34 INFO - Running pre-action listener: _resource_record_pre_action 23:42:34 INFO - Running main action method: populate_webroot 23:42:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:42:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:42:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:42:34 INFO - '--tppagecycles', 23:42:34 INFO - '7'], 23:42:34 INFO - 'tests': ['tsvgm']}}, 23:42:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:42:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:42:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:42:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 23:42:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:42:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:42:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:42:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:42:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:42:34 INFO - 'talos_options': ['--e10s'], 23:42:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:42:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:42:34 INFO - 'tests': ['damp', 'tps']}, 23:42:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:42:34 INFO - 'talos_options': ['--e10s'], 23:42:34 INFO - 'tests': ['damp', 'tps']}, 23:42:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:42:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:42:34 INFO - 'other': {'tests': ['a11yr', 23:42:34 INFO - 'ts_paint', 23:42:34 INFO - 'tpaint', 23:42:34 INFO - 'sessionrestore', 23:42:34 INFO - 'sessionrestore_no_auto_restore']}, 23:42:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:42:34 INFO - 'tests': ['a11yr', 23:42:34 INFO - 'ts_paint', 23:42:34 INFO - 'tpaint', 23:42:34 INFO - 'sessionrestore', 23:42:34 INFO - 'sessionrestore_no_auto_restore']}, 23:42:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:42:34 INFO - 'tests': ['a11yr', 23:42:34 INFO - 'ts_paint', 23:42:34 INFO - 'tpaint', 23:42:34 INFO - 'sessionrestore', 23:42:34 INFO - 'sessionrestore_no_auto_restore']}, 23:42:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:42:34 INFO - 'tests': ['a11yr', 23:42:34 INFO - 'ts_paint', 23:42:34 INFO - 'tpaint', 23:42:34 INFO - 'sessionrestore', 23:42:34 INFO - 'sessionrestore_no_auto_restore']}, 23:42:34 INFO - 'other_l64': {'tests': ['a11yr', 23:42:34 INFO - 'ts_paint', 23:42:34 INFO - 'tpaint', 23:42:34 INFO - 'sessionrestore', 23:42:34 INFO - 'sessionrestore_no_auto_restore']}, 23:42:34 INFO - 'other_nol64': {'tests': ['a11yr', 23:42:34 INFO - 'ts_paint', 23:42:34 INFO - 'tpaint', 23:42:34 INFO - 'sessionrestore', 23:42:34 INFO - 'sessionrestore_no_auto_restore']}, 23:42:34 INFO - 'svgr': {'tests': ['tsvgx', 23:42:34 INFO - 'tsvgr_opacity', 23:42:34 INFO - 'tart', 23:42:34 INFO - 'tscrollx', 23:42:34 INFO - 'cart']}, 23:42:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:42:34 INFO - 'tests': ['tsvgx', 23:42:34 INFO - 'tsvgr_opacity', 23:42:34 INFO - 'tart', 23:42:34 INFO - 'tscrollx', 23:42:34 INFO - 'cart']}, 23:42:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:42:34 INFO - 'tests': ['tp5o']}, 23:42:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:42:34 INFO - 'talos_options': ['--e10s'], 23:42:34 INFO - 'tests': ['tp5o']}, 23:42:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:42:34 INFO - 'talos_options': ['--xperf_path', 23:42:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:42:34 INFO - 'tests': ['tp5n']}, 23:42:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:42:34 INFO - 'talos_options': ['--e10s', 23:42:34 INFO - '--xperf_path', 23:42:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:42:34 INFO - 'tests': ['tp5n']}}, 23:42:34 INFO - 'talos.zip': {'path': '', 23:42:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:42:34 INFO - Running post-action listener: _resource_record_post_action 23:42:34 INFO - ##### 23:42:34 INFO - ##### Running create-virtualenv step. 23:42:34 INFO - ##### 23:42:34 INFO - Running pre-action listener: _resource_record_pre_action 23:42:34 INFO - Running main action method: create_virtualenv 23:42:34 INFO - Creating virtualenv /builds/slave/test/build/venv 23:42:34 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 23:42:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:42:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:42:34 INFO - Using real prefix '/tools/python27' 23:42:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:42:35 INFO - Installing distribute.............................................................................................................................................................................................done. 23:42:38 INFO - Installing pip.................done. 23:42:38 INFO - Return code: 0 23:42:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:42:38 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')]} 23:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:38 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')]} 23:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:38 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 0x10f8f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8fe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef0ad94570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f79ad30>, '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 0x10f5bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f791b20>, '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.hG2r4mfW1l/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.0mQbw35P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:42:38 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 23:42:38 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 23:42:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hG2r4mfW1l/Render', 23:42:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:42:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:42:38 INFO - 'HOME': '/Users/cltbld', 23:42:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:42:38 INFO - 'LOGNAME': 'cltbld', 23:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:38 INFO - 'MOZ_NO_REMOTE': '1', 23:42:38 INFO - 'NO_EM_RESTART': '1', 23:42:38 INFO - 'PAGER': '/bin/cat', 23:42:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:38 INFO - 'PWD': '/builds/slave/test', 23:42:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:42:38 INFO - 'SHELL': '/bin/bash', 23:42:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0mQbw35P8O/Listeners', 23:42:38 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:42:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:42:38 INFO - 'USER': 'cltbld', 23:42:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:42:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:38 INFO - 'XPC_FLAGS': '0x0', 23:42:38 INFO - 'XPC_SERVICE_NAME': '0', 23:42:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:38 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 23:42:38 INFO - Cleaning up... 23:42:38 INFO - Return code: 0 23:42:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:42:38 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')]} 23:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:38 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')]} 23:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:38 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 0x10f8f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8fe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef0ad94570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f79ad30>, '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 0x10f5bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f791b20>, '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.hG2r4mfW1l/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.0mQbw35P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:42:38 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 23:42:38 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 23:42:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hG2r4mfW1l/Render', 23:42:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:42:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:42:38 INFO - 'HOME': '/Users/cltbld', 23:42:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:42:38 INFO - 'LOGNAME': 'cltbld', 23:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:38 INFO - 'MOZ_NO_REMOTE': '1', 23:42:38 INFO - 'NO_EM_RESTART': '1', 23:42:38 INFO - 'PAGER': '/bin/cat', 23:42:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:38 INFO - 'PWD': '/builds/slave/test', 23:42:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:42:38 INFO - 'SHELL': '/bin/bash', 23:42:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0mQbw35P8O/Listeners', 23:42:38 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:42:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:42:38 INFO - 'USER': 'cltbld', 23:42:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:42:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:38 INFO - 'XPC_FLAGS': '0x0', 23:42:38 INFO - 'XPC_SERVICE_NAME': '0', 23:42:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:38 INFO - Downloading/unpacking psutil>=0.7.1 23:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:42:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:42:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:42:41 INFO - Installing collected packages: psutil 23:42:41 INFO - Running setup.py install for psutil 23:42:41 INFO - building 'psutil._psutil_osx' extension 23:42:41 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 23:42:42 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 23:42:42 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 23:42:42 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 23:42:42 INFO - building 'psutil._psutil_posix' extension 23:42:42 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 23:42:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:42:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:42:42 INFO - ^ 23:42:42 INFO - 1 warning generated. 23:42:42 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 23:42:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:42:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:42:42 INFO - Successfully installed psutil 23:42:42 INFO - Cleaning up... 23:42:42 INFO - Return code: 0 23:42:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:42:42 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')]} 23:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:42 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')]} 23:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:42 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 0x10f8f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8fe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef0ad94570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f79ad30>, '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 0x10f5bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f791b20>, '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.hG2r4mfW1l/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.0mQbw35P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:42:42 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 23:42:42 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 23:42:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hG2r4mfW1l/Render', 23:42:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:42:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:42:42 INFO - 'HOME': '/Users/cltbld', 23:42:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:42:42 INFO - 'LOGNAME': 'cltbld', 23:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:42 INFO - 'MOZ_NO_REMOTE': '1', 23:42:42 INFO - 'NO_EM_RESTART': '1', 23:42:42 INFO - 'PAGER': '/bin/cat', 23:42:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:42 INFO - 'PWD': '/builds/slave/test', 23:42:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:42:42 INFO - 'SHELL': '/bin/bash', 23:42:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0mQbw35P8O/Listeners', 23:42:42 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:42:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:42:42 INFO - 'USER': 'cltbld', 23:42:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:42:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:42 INFO - 'XPC_FLAGS': '0x0', 23:42:42 INFO - 'XPC_SERVICE_NAME': '0', 23:42:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:42:42 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 23:42:42 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 23:42:42 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 23:42:42 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 23:42:42 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 23:42:42 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 23:42:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:42:45 INFO - Installing collected packages: mozsystemmonitor 23:42:45 INFO - Running setup.py install for mozsystemmonitor 23:42:45 INFO - Successfully installed mozsystemmonitor 23:42:45 INFO - Cleaning up... 23:42:45 INFO - Return code: 0 23:42:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:42:45 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')]} 23:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:45 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')]} 23:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:45 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 0x10f8f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8fe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef0ad94570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f79ad30>, '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 0x10f5bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f791b20>, '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.hG2r4mfW1l/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.0mQbw35P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:42:45 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 23:42:45 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 23:42:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hG2r4mfW1l/Render', 23:42:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:42:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:42:45 INFO - 'HOME': '/Users/cltbld', 23:42:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:42:45 INFO - 'LOGNAME': 'cltbld', 23:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:45 INFO - 'MOZ_NO_REMOTE': '1', 23:42:45 INFO - 'NO_EM_RESTART': '1', 23:42:45 INFO - 'PAGER': '/bin/cat', 23:42:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:45 INFO - 'PWD': '/builds/slave/test', 23:42:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:42:45 INFO - 'SHELL': '/bin/bash', 23:42:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0mQbw35P8O/Listeners', 23:42:45 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:42:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:42:45 INFO - 'USER': 'cltbld', 23:42:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:42:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:45 INFO - 'XPC_FLAGS': '0x0', 23:42:45 INFO - 'XPC_SERVICE_NAME': '0', 23:42:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:45 INFO - Downloading/unpacking blobuploader==1.2.4 23:42: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 23:42: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 23:42: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 23:42: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 23:42: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 23:42: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 23:42:48 INFO - Downloading blobuploader-1.2.4.tar.gz 23:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:42:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:42:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:49 INFO - Downloading docopt-0.6.1.tar.gz 23:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:42:49 INFO - Installing collected packages: blobuploader, requests, docopt 23:42:49 INFO - Running setup.py install for blobuploader 23:42:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:42:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:42:49 INFO - Running setup.py install for requests 23:42:49 INFO - Running setup.py install for docopt 23:42:50 INFO - Successfully installed blobuploader requests docopt 23:42:50 INFO - Cleaning up... 23:42:50 INFO - Return code: 0 23:42:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:42:50 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')]} 23:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:50 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')]} 23:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:50 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 0x10f8f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8fe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef0ad94570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f79ad30>, '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 0x10f5bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f791b20>, '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.hG2r4mfW1l/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.0mQbw35P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:42:50 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 23:42:50 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 23:42:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hG2r4mfW1l/Render', 23:42:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:42:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:42:50 INFO - 'HOME': '/Users/cltbld', 23:42:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:42:50 INFO - 'LOGNAME': 'cltbld', 23:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:50 INFO - 'MOZ_NO_REMOTE': '1', 23:42:50 INFO - 'NO_EM_RESTART': '1', 23:42:50 INFO - 'PAGER': '/bin/cat', 23:42:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:50 INFO - 'PWD': '/builds/slave/test', 23:42:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:42:50 INFO - 'SHELL': '/bin/bash', 23:42:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0mQbw35P8O/Listeners', 23:42:50 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:42:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:42:50 INFO - 'USER': 'cltbld', 23:42:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:42:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:50 INFO - 'XPC_FLAGS': '0x0', 23:42:50 INFO - 'XPC_SERVICE_NAME': '0', 23:42:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:42:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-rEPisq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:42:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-9_DXjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:42:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-pk4kE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:42:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-i2cyJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:42:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-YMEPDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:42:50 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-xRTods-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:42:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-eqibw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:42:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ulMW30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:42:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-QGLtkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:42:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-jY42FV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:42:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-bawgWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:42:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-O3zk2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:42:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-yrfCff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:42:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-BM4U6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-k4WGKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:42:51 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Q20ACO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:42:52 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-d9qQ6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:42:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:42:52 INFO - Running setup.py install for manifestparser 23:42:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:42:52 INFO - Running setup.py install for mozcrash 23:42:52 INFO - Running setup.py install for mozdebug 23:42:52 INFO - Running setup.py install for mozdevice 23:42:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:42:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:42:52 INFO - Running setup.py install for mozfile 23:42:52 INFO - Running setup.py install for mozhttpd 23:42:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:42:53 INFO - Running setup.py install for mozinfo 23:42:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:42:53 INFO - Running setup.py install for mozInstall 23:42:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:42:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:42:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:42:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:42:53 INFO - Running setup.py install for mozleak 23:42:53 INFO - Running setup.py install for mozlog 23:42:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:42:53 INFO - Running setup.py install for moznetwork 23:42:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:42:53 INFO - Running setup.py install for mozprocess 23:42:53 INFO - Running setup.py install for mozprofile 23:42:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:42:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:42:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:42:54 INFO - Running setup.py install for mozrunner 23:42:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:42:54 INFO - Running setup.py install for mozscreenshot 23:42:54 INFO - Running setup.py install for moztest 23:42:54 INFO - Running setup.py install for mozversion 23:42:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:42:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:42:54 INFO - Cleaning up... 23:42:54 INFO - Return code: 0 23:42:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:42:54 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')]} 23:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:54 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')]} 23:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:54 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 0x10f8f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8fe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef0ad94570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f79ad30>, '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 0x10f5bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f791b20>, '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.hG2r4mfW1l/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.0mQbw35P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:42:54 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 23:42:54 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 23:42:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hG2r4mfW1l/Render', 23:42:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:42:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:42:54 INFO - 'HOME': '/Users/cltbld', 23:42:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:42:54 INFO - 'LOGNAME': 'cltbld', 23:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:54 INFO - 'MOZ_NO_REMOTE': '1', 23:42:54 INFO - 'NO_EM_RESTART': '1', 23:42:54 INFO - 'PAGER': '/bin/cat', 23:42:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:54 INFO - 'PWD': '/builds/slave/test', 23:42:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:42:54 INFO - 'SHELL': '/bin/bash', 23:42:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0mQbw35P8O/Listeners', 23:42:54 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:42:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:42:54 INFO - 'USER': 'cltbld', 23:42:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:42:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:54 INFO - 'XPC_FLAGS': '0x0', 23:42:54 INFO - 'XPC_SERVICE_NAME': '0', 23:42:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:42:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Mlp4kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:42:55 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)) 23:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:42:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-eO_cdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:42:55 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)) 23:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:42:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-K2sIQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:42:55 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)) 23:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:42:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-kMdn7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:42:55 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)) 23:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:42:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-qxip5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:42:55 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)) 23:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:42:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Sd1LWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:42:55 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)) 23:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:42:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-2vV9uT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:42:55 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)) 23:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:42:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-cFwJ0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:42:55 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)) 23:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:42:55 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-P3pU4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:42:56 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)) 23:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:42:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-mS4fvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:42:56 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)) 23:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:42:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-6xxwoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:42:56 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)) 23:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:42:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Cci9Qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:42:56 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)) 23:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:42:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-k_lxWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:42:56 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)) 23:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:42:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ILWUlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:42:56 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)) 23:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-uCcQ5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:56 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)) 23:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:42:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-NGYmTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:42:56 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)) 23:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:42:56 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-WKWNO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:42:56 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)) 23:42:56 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)) 23:42:56 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)) 23:42:56 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)) 23:42:56 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)) 23:42:56 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)) 23:42:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:59 INFO - Downloading blessings-1.6.tar.gz 23:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:42:59 INFO - Installing collected packages: blessings 23:42:59 INFO - Running setup.py install for blessings 23:42:59 INFO - Successfully installed blessings 23:42:59 INFO - Cleaning up... 23:42:59 INFO - Return code: 0 23:42:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:42:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:42:59 INFO - Reading from file tmpfile_stdout 23:42:59 INFO - Current package versions: 23:42:59 INFO - blessings == 1.6 23:42:59 INFO - blobuploader == 1.2.4 23:42:59 INFO - docopt == 0.6.1 23:42:59 INFO - manifestparser == 1.1 23:42:59 INFO - mozInstall == 1.12 23:42:59 INFO - mozcrash == 0.16 23:42:59 INFO - mozdebug == 0.1 23:42:59 INFO - mozdevice == 0.48 23:42:59 INFO - mozfile == 1.2 23:42:59 INFO - mozhttpd == 0.7 23:42:59 INFO - mozinfo == 0.9 23:42:59 INFO - mozleak == 0.1 23:42:59 INFO - mozlog == 3.1 23:42:59 INFO - moznetwork == 0.27 23:42:59 INFO - mozprocess == 0.22 23:42:59 INFO - mozprofile == 0.28 23:42:59 INFO - mozrunner == 6.11 23:42:59 INFO - mozscreenshot == 0.1 23:42:59 INFO - mozsystemmonitor == 0.0 23:42:59 INFO - moztest == 0.7 23:42:59 INFO - mozversion == 1.4 23:42:59 INFO - psutil == 3.1.1 23:42:59 INFO - requests == 1.2.3 23:42:59 INFO - wsgiref == 0.1.2 23:42:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:59 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 0x10f8f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8fe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef0ad94570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f79ad30>, '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 0x10f5bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f791b20>, '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.hG2r4mfW1l/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.0mQbw35P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:42:59 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 23:42:59 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 23:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hG2r4mfW1l/Render', 23:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:42:59 INFO - 'HOME': '/Users/cltbld', 23:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:42:59 INFO - 'LOGNAME': 'cltbld', 23:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:59 INFO - 'MOZ_NO_REMOTE': '1', 23:42:59 INFO - 'NO_EM_RESTART': '1', 23:42:59 INFO - 'PAGER': '/bin/cat', 23:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:59 INFO - 'PWD': '/builds/slave/test', 23:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:42:59 INFO - 'SHELL': '/bin/bash', 23:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0mQbw35P8O/Listeners', 23:42:59 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:42:59 INFO - 'USER': 'cltbld', 23:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:59 INFO - 'XPC_FLAGS': '0x0', 23:42:59 INFO - 'XPC_SERVICE_NAME': '0', 23:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:00 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)) 23:43:00 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)) 23:43:00 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)) 23:43:00 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)) 23:43:00 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)) 23:43:00 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)) 23:43:00 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)) 23:43:00 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)) 23:43:00 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)) 23:43:00 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)) 23:43:00 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)) 23:43:00 INFO - Cleaning up... 23:43:00 INFO - Return code: 0 23:43:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:43: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')]} 23:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43: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')]} 23:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8fe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef0ad94570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f79ad30>, '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 0x10f5bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f791b20>, '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.hG2r4mfW1l/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.0mQbw35P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:43: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', 'jsonschema'] in /builds/slave/test/build 23:43: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 jsonschema 23:43:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hG2r4mfW1l/Render', 23:43:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:00 INFO - 'HOME': '/Users/cltbld', 23:43:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:00 INFO - 'LOGNAME': 'cltbld', 23:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:00 INFO - 'MOZ_NO_REMOTE': '1', 23:43:00 INFO - 'NO_EM_RESTART': '1', 23:43:00 INFO - 'PAGER': '/bin/cat', 23:43:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:00 INFO - 'PWD': '/builds/slave/test', 23:43:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:00 INFO - 'SHELL': '/bin/bash', 23:43:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0mQbw35P8O/Listeners', 23:43:00 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:43:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:00 INFO - 'USER': 'cltbld', 23:43:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:00 INFO - 'XPC_FLAGS': '0x0', 23:43:00 INFO - 'XPC_SERVICE_NAME': '0', 23:43:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:00 INFO - Downloading/unpacking jsonschema 23:43: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 23:43: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 23:43: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 23:43: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 23:43: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 23:43: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 23:43:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:43:02 INFO - Downloading/unpacking functools32 (from jsonschema) 23:43:02 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 23:43:02 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 23:43:02 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 23:43:02 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 23:43:02 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 23:43:02 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 23:43:02 INFO - Downloading functools32-3.2.3-2.tar.gz 23:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:43:03 INFO - warning: no files found matching '*.txt' 23:43:03 INFO - no previously-included directories found matching 'build' 23:43:03 INFO - no previously-included directories found matching 'dist' 23:43:03 INFO - no previously-included directories found matching '.git*' 23:43:03 INFO - Installing collected packages: jsonschema, functools32 23:43:03 INFO - Running setup.py install for functools32 23:43:03 INFO - warning: no files found matching '*.txt' 23:43:03 INFO - no previously-included directories found matching 'build' 23:43:03 INFO - no previously-included directories found matching 'dist' 23:43:03 INFO - no previously-included directories found matching '.git*' 23:43:03 INFO - Successfully installed jsonschema functools32 23:43:03 INFO - Cleaning up... 23:43:03 INFO - Return code: 0 23:43:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:43:03 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 0x10f8f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8fe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef0ad94570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f79ad30>, '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 0x10f5bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f791b20>, '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.hG2r4mfW1l/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.0mQbw35P8O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:43:03 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 23:43:03 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 23:43:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hG2r4mfW1l/Render', 23:43:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:03 INFO - 'HOME': '/Users/cltbld', 23:43:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:03 INFO - 'LOGNAME': 'cltbld', 23:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:03 INFO - 'MOZ_NO_REMOTE': '1', 23:43:03 INFO - 'NO_EM_RESTART': '1', 23:43:03 INFO - 'PAGER': '/bin/cat', 23:43:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:03 INFO - 'PWD': '/builds/slave/test', 23:43:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:03 INFO - 'SHELL': '/bin/bash', 23:43:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0mQbw35P8O/Listeners', 23:43:03 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:43:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:03 INFO - 'USER': 'cltbld', 23:43:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:03 INFO - 'XPC_FLAGS': '0x0', 23:43:03 INFO - 'XPC_SERVICE_NAME': '0', 23:43:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:03 INFO - Downloading/unpacking flake8 23:43: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 23:43: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 23:43: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 23:43: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 23:43: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 23:43: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 23:43:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:43:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:43:05 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 23:43:05 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 23:43:05 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 23:43:05 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 23:43:05 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 23:43:05 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 23:43:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:43:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:43:06 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 23:43:06 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 23:43:06 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 23:43:06 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 23:43:06 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 23:43:06 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 23:43:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:43:06 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 23:43:06 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 23:43:06 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 23:43:06 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 23:43:06 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 23:43:06 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 23:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:43:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:43:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:43:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:43:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:43:07 INFO - no previously-included directories found matching 'docs/_build' 23:43:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:43:07 INFO - Running setup.py install for pep8 23:43:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:43:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:43:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:43:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:43:07 INFO - no previously-included directories found matching 'docs/_build' 23:43:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:43:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:43:07 INFO - Cleaning up... 23:43:07 INFO - Return code: 0 23:43:07 INFO - Running post-action listener: _resource_record_post_action 23:43:07 INFO - Running post-action listener: _start_resource_monitoring 23:43:07 INFO - Starting resource monitoring. 23:43:07 INFO - ##### 23:43:07 INFO - ##### Running install step. 23:43:07 INFO - ##### 23:43:07 INFO - Running pre-action listener: _resource_record_pre_action 23:43:07 INFO - Running main action method: install 23:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:43:07 INFO - Reading from file tmpfile_stdout 23:43:07 INFO - Detecting whether we're running mozinstall >=1.0... 23:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:43:07 INFO - Reading from file tmpfile_stdout 23:43:07 INFO - Output received: 23:43:07 INFO - Usage: mozinstall [options] installer 23:43:07 INFO - Options: 23:43:07 INFO - -h, --help show this help message and exit 23:43:07 INFO - -d DEST, --destination=DEST 23:43:07 INFO - Directory to install application into. [default: 23:43:07 INFO - "/builds/slave/test"] 23:43:07 INFO - --app=APP Application being installed. [default: firefox] 23:43:07 INFO - mkdir: /builds/slave/test/build/application 23:43:07 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'] 23:43:07 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 23:43:41 INFO - Reading from file tmpfile_stdout 23:43:41 INFO - Output received: 23:43:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:43:41 INFO - Running post-action listener: _resource_record_post_action 23:43:41 INFO - ##### 23:43:41 INFO - ##### Running run-tests step. 23:43:41 INFO - ##### 23:43:41 INFO - Running pre-action listener: _resource_record_pre_action 23:43:41 INFO - Running main action method: run_tests 23:43:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:43:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:43:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:43:41 INFO - 2016-02-10 23:43:41.700 screenresolution[1936:11201] starting screenresolution argv=screenresolution get 23:43:41 INFO - 2016-02-10 23:43:41.703 screenresolution[1936:11201] Display 0: 1600x1200x32@60 23:43:41 INFO - 2016-02-10 23:43:41.709 screenresolution[1937:11203] starting screenresolution argv=screenresolution list 23:43:41 INFO - Available Modes on Display 0 23:43:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:43:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:43:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:43:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:43:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:43:41 INFO - Intel Iris: 23:43:41 INFO - Chipset Model: Intel Iris 23:43:41 INFO - Type: GPU 23:43:41 INFO - Bus: Built-In 23:43:41 INFO - VRAM (Dynamic, Max): 1536 MB 23:43:41 INFO - Vendor: Intel (0x8086) 23:43:41 INFO - Device ID: 0x0a2e 23:43:41 INFO - Revision ID: 0x0009 23:43:41 INFO - Displays: 23:43:41 INFO - Display: 23:43:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:43:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:43:41 INFO - Display Serial Number: 1600x1200 60 23:43:41 INFO - Main Display: Yes 23:43:41 INFO - Mirror: Off 23:43:41 INFO - Online: Yes 23:43:41 INFO - Rotation: Supported 23:43:41 INFO - Return code: 0 23:43:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:43:41 INFO - Python 2.7.3 23:43:41 INFO - Return code: 0 23:43:41 INFO - grabbing minidump binary from tooltool 23:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:43:41 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 0x10f79ad30>, '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 0x10f5bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f791b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:43:41 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 23:43:41 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 23:43:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:43:42 INFO - Return code: 0 23:43:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:43:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:43:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:43:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:43:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:43:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:43:43 INFO - Return code: 0 23:43:43 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:43:43 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0073 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:43:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hG2r4mfW1l/Render', 23:43:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:43:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:43:43 INFO - 'HOME': '/Users/cltbld', 23:43:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:43:43 INFO - 'LOGNAME': 'cltbld', 23:43:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:43:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:43 INFO - 'MOZ_NO_REMOTE': '1', 23:43:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:43:43 INFO - 'NO_EM_RESTART': '1', 23:43:43 INFO - 'PAGER': '/bin/cat', 23:43:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:43 INFO - 'PWD': '/builds/slave/test', 23:43:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:43:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:43:43 INFO - 'SHELL': '/bin/bash', 23:43:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0mQbw35P8O/Listeners', 23:43:43 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:43:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:43:43 INFO - 'USER': 'cltbld', 23:43:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:43:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:43 INFO - 'XPC_FLAGS': '0x0', 23:43:43 INFO - 'XPC_SERVICE_NAME': '0', 23:43:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:43:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:43:43 INFO - mozversion application_buildid: 20160210224431 23:43:43 INFO - mozversion application_changeset: 0add7cd89394362d9458cc1a9c3a63d8ac4205e2 23:43:43 INFO - mozversion application_display_name: Nightly 23:43:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:43:43 INFO - mozversion application_name: Firefox 23:43:43 INFO - mozversion application_remotingname: firefox 23:43:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:43:43 INFO - mozversion application_vendor: Mozilla 23:43:43 INFO - mozversion application_version: 47.0a1 23:43:43 INFO - mozversion platform_buildid: 20160210224431 23:43:43 INFO - mozversion platform_changeset: 0add7cd89394362d9458cc1a9c3a63d8ac4205e2 23:43:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:43:43 INFO - mozversion platform_version: 47.0a1 23:43:43 INFO - using testdate: 1455176623 23:43:43 INFO - actual date: 1455176623 23:43:43 INFO - starting webserver on 'localhost:49452' 23:43:43 INFO - SUITE-START | Running 2 tests 23:43:43 INFO - TEST-START | dromaeo_css 23:43:43 INFO - operating with platform_type : mac_ 23:43:43 INFO - Initialising browser for dromaeo_css test... 23:43:43 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpTPPNQZ/profile http://localhost:49452/getInfo.html) 23:43:46 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 23:43:46 INFO - PROCESS | 1955 | colorDepth:24 23:43:46 INFO - PROCESS | 1955 | Browser inner width/height: 1024/689 23:43:46 INFO - PROCESS | 1955 | __metrics 23:43:46 INFO - PROCESS | 1955 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:43:46 INFO - PROCESS | 1955 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:43:46 INFO - TEST-INFO | 1955: exit 0 23:43:46 INFO - Browser initialized. 23:43:46 INFO - Running cycle 1/1 for dromaeo_css test... 23:43:46 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpTPPNQZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:43:58 INFO - PROCESS | 1958 | RSS: Main: 246841344 23:43:58 INFO - PROCESS | 1958 | 23:44:50 INFO - PROCESS | 1958 | 1455176690539 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] 23:47:00 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49452/tests/dromaeo/cssquery-ext.html) 23:47:01 INFO - PROCESS | 1958 | RSS: Main: 360783872 23:47:01 INFO - PROCESS | 1958 | 23:50:04 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-ext.html (next: http://localhost:49452/tests/dromaeo/cssquery-jquery.html) 23:50:05 INFO - PROCESS | 1958 | RSS: Main: 383156224 23:50:05 INFO - PROCESS | 1958 | 23:53:07 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49452/tests/dromaeo/cssquery-mootools.html) 23:53:07 INFO - PROCESS | 1958 | RSS: Main: 379277312 23:53:07 INFO - PROCESS | 1958 | 23:56:10 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49452/tests/dromaeo/cssquery-prototype.html) 23:56:10 INFO - PROCESS | 1958 | RSS: Main: 369192960 23:56:10 INFO - PROCESS | 1958 | 23:59:13 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49452/tests/dromaeo/cssquery-yui.html) 23:59:14 INFO - PROCESS | 1958 | RSS: Main: 341688320 23:59:14 INFO - PROCESS | 1958 | 00:02:17 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-yui.html (next: http://localhost:49452/tests/dromaeo/cssquery-dojo.html) 00:02:17 INFO - PROCESS | 1958 | RSS: Main: 383852544 00:02:17 INFO - PROCESS | 1958 | 00:02:17 INFO - PROCESS | 1958 | __start_tp_report 00:02:17 INFO - PROCESS | 1958 | _x_x_mozilla_page_load 00:02:17 INFO - PROCESS | 1958 | _x_x_mozilla_page_load_details 00:02:17 INFO - PROCESS | 1958 | |i|pagename|runs| 00:02:17 INFO - PROCESS | 1958 | |0;dojo.html;2961.3929144525373;3375.5274261603377;3433.8626454941805;3461.792292462451;3476.91307717307;5553.08374118271;5630.634008789431;5633.070543360346;5640.7590330127405;5691.260136182295;5640.0693885508945;5640.238567793347;5742.425757424256;5774.018416869132;5824.446677565635;5067.189249720045;5108.540231379176;5128.153854613985;5137.2037334213255;5222.529972302492;5173.430922598511;5214.322138122039;5241.42344342122;5253.369595648527;5281.788728450857;5054.039732450841;5123.026624941286;5135.255387968761;5141.845744627667;5170.819021334254;5105.566026887682;5109.105906466353;5117;5129.743512824344;5163.0190263849745;5057.974710126463;5083.872903177413;5097.643164978453;5118.411382691001;5177.922331165036;4608.654350923661;5544.833654990357;5546.306711661043;5550.195221692832;5673.886522269531;6070.969645151746;6141.938580614182;6167.105769663373;6171.506279497674;6173.9073913891325;5506.972465137689;6048.848778780522;6115.544587952024;6157.4458298753325;6248.968755156195;5170.922436163461;5599.496045355897;5707.429257074259;5764.827055188267;5779.450952159538;6186.721597528122;6205.81382558524;6213.596116252519;6216.937830621727;6233.688315584293;5950.285965684146;6037.667928263988;6060.484858786965;6089.025755879038;6138.907916381258;6158.568900177034;6174.536909731698;6176.969115154486;6193.4425901669065;6200.3799620038535;6131.50947924165;6133.601315914451;6162;6171.228596425447;6179.876402471926;6022.18700475439;6114.814446323802;6132.294786099566;6183.0107182850525;6227.96886015567;4775.808967641256;4780.11567859947;4789;4815.374001379868;4851.902961940741;4306.698531102793;4325.351197320427;4334.28484300087;4359.934600980988;4423.756693381831;5470.234167216593;5507.669539827543;5509.421510741315;5531.3362396511875;5549.805756798492;6126.670355029888;6147.231596050494;6170.444659980623;6193.81418557435;6195.504359651217;5563.888722225533;5575.247341608912;5582.525485333711;5594.692291923983;5614.045612245928;5290.576753859682;5312.814051508256;5320.707361095099;5335.919961200585;5390.299261096111;6101.82280290701;6211.875762484816;6217.067439883963;6251.718672659741;6272.560920735687;6081.209063992285;6129.325774164749;6133.26400831903;6134.4172303631085;6140.140380346845;6174.66039367839;6188.81433556994;6204.224471941007;6210;6217.844553886189;6000.399960003964;6087.208662873798;6101.389861013863;6105.389461053859;6116.510679145568;6129.053167990421;6137.101203255209;6143.84640383994;6145.555794388226;6194.194754681863;6028.547858910511;6028.728707208098;6031.7587296507645;6034.064719968412;6082.72627731762;5900.144479050599;5949.6430214187285;6000.729967151401;6070.2412198475195;6081.756729730761;5699.945510080483;5780.855478613068;5856.531477481876;5910.763569457174;5966.67183304905;4744.430668319824;6033.276006879202;6041;6065.939340606537;6111.205543279345;5789.623674461147;5911.615744976562;5918.3489816121055;5919.91120133207;5949.553783466171 00:02:17 INFO - PROCESS | 1958 | |1;ext.html;454.12580781994654;466.1213612340739;470.18188352267066;488.7556221889055;556.799552161222;29125.27186820328;29643.40713185735;37528;37699.81150094246;37719.811400942956;40032;40345.59654403455;40362.59637403625;40496.59503404965;40504;7660.502067365631;9441.291903107278;9652.662156824512;9655.951720241388;9674.90325096747;9528.809423811519;9680.031996800333;9680.273979451535;9685.70942871715;9704.563294651758;9757.219422446222;9813.65652202173;9819.656312029081;9823.901760982406;9827.459489728062;9707.66023189185;9719.805603887953;9749.122578967892;9808.411495310304;9809.803803923916;8148.796280092985;9696.95151524238;9719.46542940138;9727.805443891153;9732.513374331325;38889;39117.21765564673;39160;39203;39203.60796392028;2795.9580606290924;3157.431662300785;3246.4643333849885;3435.7423193260606;3754.4743735877;28171.014014509597;28346.2913427166;28418.863245470155;29015.85492072526;29656.703432965827;2378.7383387827326;2671.412289296352;2808.311963568918;2827.1801177658454;2883.0774152271283;464821;467406.6629666864;467428;467927.9999999966;468165.3183468156;62364.688176558826;62447.687761560905;62623;62854.0571891422;62915;66198.33801662018;66348.6682566584;66433;66475.66762166159;66478.66760666166;16606.584835379213;16793.496195114167;16846.24191911367;16864;16870.746938795928;11696.239744416585;12126.696832579257;12763.808542871864;12843.807342889864;12859.035572332112;17951.910240448713;18907.86552806836;19403;19611.60776784456;19676.3113291037;6511.316311787289;7645.235476452311;7735.3424958878;7752.728654497066;7835.49069310493;931.5621657820814;971.708487453761;977.359829311802;1073.4096247064083;1074.9301295415773;23551.593421353573;27708.30729231785;28163.577546336823;28244.293892652848;28733.28166795805;917.7613820406609;987.6345752071779;989.1987490133015;1080.8162612355918;1087.429099722636;13984.160950343012;14054.43782248719;14112.153270803785;14174.574762757135;14179.645508862155;437370;442586.787066069;554997;656707;661474;49173;49265.014699705804;49989.75005125024;50112.24831627528;50136.997260054595;1429.028260782657;1433.4624515806572;1454.3964254834125;1455.1196526101767;1457.8615031571771;23019.539609208055;27631.447371052065;29043.85478072596;29688.406231875673;30343.393132137677;50033;50604.49395505998;50653.49346506635;50726.23910641269;50779.492205078954;439892;442186;442245;442762;443379;28972.985945491808;30147.64335604947;30149.64326605264;30164.54753178748;30196.54705179468;42275.94310142271;43013.92465188395;43787.56212437962;43916.78041609899;44601.55398445974;32340;33589.99230023103;34588.827055865564;34748.82625586856;35361.469577956865;33619;33973.49039764455;34201.82899085488;35079.82460087785;35238.823805880806;34724;34990.47514287237;34995;35802.641973580976;36245.81877090598;29505;29588.112356629335;31122.844385778833;31203;31233.8438307807;18591.721124182877;23749.52500950006;24595.4401431327;25189.62215566731;25798.968041278138 00:02:17 INFO - PROCESS | 1958 | |2;jquery.html;359.77693829825506;361.761237583195;367.39196629578043;371.5003320533881;374.38040043727625;14836.703265934675;15154.924225378858;18542.721859172107;18716.53208669782;19504.024798760078;11393.088552915768;11666.008389286899;11667.358295293756;12042.518299268018;18430.815691843076;5212.687238765668;5403.891922161554;5403.945960540404;5405.621606487547;5414.8917021659545;3872.7289089763726;4090.5909409059004;4725.527447255281;5706.087026075828;5929.080992446177;5653.575981801361;5821.068629019358;5845.123231515286;5879.911801322984;5896.911546326808;5653.604247702662;5746.770129194827;5789;5792.68140252286;5801.071828507418;5507.449255074501;5520.309961254843;5672.205891175238;5687.601867869251;5698.088305871041;22692.97881595332;22863.88568057149;23572;23801.642975355382;23868.522629547486;2262.558801033799;2353.5645905507363;2461.778439940396;2531.291238453236;2789.0517224143887;7454.40364770817;9556.283278754052;9558.996305387904;9954.651587194487;9978.101970822661;1747.3622127923215;1750.0549703160277;1780.5459607799928;1794.1119146022672;1827.259959716317;92731.03482661508;97043.51478242634;97167.0283297165;97765.5111724451;98681.5197772034;10606.204534659932;10799.082078023299;10828.512716927757;10843.566257349776;10916.235863489639;13015.023873209548;13259.867401326057;13286.734265314639;13298.73402531944;13301.73396532064;6817.556858804261;8274.875876861732;8289.626966786389;8378.371622128243;8394.580270986426;8350.749477515685;8377.790555236168;8386.371022173362;8484.660613575512;8499.74500764978;3906.941395879064;4103.4050062741335;4233.534311225824;4339.934900976488;4396.846110386121;1790.1675720789895;1834.7523084383438;1843.5759775251768;1859.1169194632712;1877.5118469197835;399.25339614919704;401.99799001004806;867.6399294292924;915.3089417489753;978.217426059164;11232.550697972152;11275.154363422776;11506.482208300647;11764.99997500222;11805.822912656316;893.9508327041945;922.898481167071;975.1029053271008;1013.8175128476945;1038.766277587552;9269.582868770787;9953.954834742393;9966.40201587907;10129.69610911659;10209.234307426972;477772.67141558684;699510;705121;719161;736826;114354;116421;121146;121309;122394.38802805929;1055.3509591601264;1145.2212495503138;1166.5450474315023;1201.0151675626078;1208.8851559101872;12750.426230819821;16865.578360541083;17116.315347385964;17261.39585114515;17663.64672706513;46856.297155542015;46965.76517117392;47044;47058.29412558883;47774.5222547784;67813.32186678267;67845.3215467839;68299;68311.65844170748;68445.31554684389;7106.786796396116;7409.259074092548;7478;7484.401247900264;7570.545767253982;9769.951150244204;11621.070314375;11690.70773230676;11878.762424751629;12068.456919438822;9702.85445718329;9868.85196722064;10313.381197128196;10317.329373590992;10416.635417760343;9883.654072107442;10361;10415.218858585486;10418.426986515815;10421;8684.305255579664;10041.845187803496;10507.579696812347;10676.786464270826;10795.784084318113;7517.933142845707;7680.692772289046;7689.307962283421;7704.614769261627;7727.845443091219;8404.20160084791;10215.540300686338;10597.205209609465;10814.621488247874;10815.24293299493 00:02:17 INFO - PROCESS | 1958 | |3;mootools.html;1307.5162189989703;1396.4623619906333;1533.2640332640335;1709.7948246210449;1922.221500292382;7788.104367997682;8386.790330241747;8551.572421378922;8552.27305679018;8558.315334773226;8264.876026859587;8503.447275927061;8512.659493620264;8519.53142577158;8522.318214542836;2161.448830548208;2207.0840601150503;2225.321277010519;2467.1488336523917;2500.0249902538026;2237.7202849643795;2240.9215677451293;2243.2148747938254;2456.91400800972;2511.7864981476596;2432.1487479382254;2458.7787099161073;2459.667944827452;2459.8032157427365;2465.8890349934204;2446.779789818907;2476.0467220120204;2477.578811602032;2483.788877945377;2486.167134010109;2450.644656524794;2474.1711526638596;2475.480149168659;2475.8143139264625;2478.7893029092547;8540.70107546233;8619.741407757778;8632.223099921037;8634.050254472004;8645.092265312114;5315.867103322409;5430.1537477257925;5474.370447398521;5479.369872464637;5479.671219726829;3641.1443310821937;3650.18935419728;3735.5143831301757;3742.270257299828;3744.5132132822832;1067.3542506783363;1068.1081297116916;1094.5840580579409;1107.617871834224;1110.0509064749683;11568.479418426192;11757.647270581896;11759.35323557204;11762.647120586482;11773.587924422603;4348.152110338454;4797.6326746876975;4828.106800241966;4909.116359055333;4992.05151021312;10069.647562335284;10083.647072352433;10099.94950025245;10100.191984641211;10100.545475453475;4595.816167353335;5441.075017247077;5471.206675032098;5484.808031718871;5486.451354864482;4935.679180853233;4978.27814966835;4982.626303027288;4984.651074424755;4989.151844186497;3699.8705045323823;3815.8473661053804;3855.055511399669;3897.0647044709067;3918.764874107506;1237.6843904804218;1329.415057374752;1348.2449828096298;1350.257358452847;1356.85752995936;1296.8378952630922;1305.3995162225483;1307.5358247821887;1335.4858379523953;1360.1363134409721;7780.961095194601;7938.126806051329;7944.126146123922;7982.281594656509;7982.800429989296;1148.6094727792424;1173.4602083041725;1173.841531393268;1193.91045671575;1201.4533387308754;6128.448439640454;6212.875742485125;6231.563790534619;6241.687915604292;6249.500039996789;10433.947830260951;10476.63331783384;10519.26365154432;10553.366797992145;10647.094996925192;10397.896021039693;10489.947550262352;10510.947445262726;10541;10556.208284378703;7923.484973476706;8262.215089566482;8332.291755200877;8335.749927502186;8350.997880254408;7771.222877712184;7827.4129440293345;7851.1363749988595;7861.52830830152;7865.842683146419;9212.401193922373;9582.904170958202;9583.712488625353;9597;9702.466364350028;9530;9732.97803730598;9889.703308900744;9956.651517196864;9996.450195239331;7444.925550744423;7509.249075092447;7517.398608111447;7522.022137122139;7529.962350188214;7391.445641577011;7563.886541701989;7795.41534384912;8078.555679437687;8107.14874938123;6825.863482730417;7093.716251350094;7490.026296581627;7639.770806875803;7782.338501227459;7305.379042781423;7339.192688804121;7534.8493030138;7563.697452102075;7579.431542634215;7372.262773722585;7601.885971710318;7708.537487750753;7746.92253077462;7748;5830.271216097988;6968.163820341591;6983.615901125487;6991.545549539263;6997.9503074539225;6809.557378770364;7078.044463997295;7109.040279562193;7121.786346409616;7135.215126336203 00:02:17 INFO - PROCESS | 1958 | |4;prototype.html;321.8953840001999;327.18204488778053;332.2623775219014;335.3243214921931;341.4656063260998;6500.902486462695;6584.045313429556;6652.866942661144;6695;6707.631080290582;6419.229692436902;6422.743090276384;6601.900971485419;6602.537822352438;6604.438622717074;4882.4141103067595;4882.731449770261;4885.36490256268;4887.633427492934;4890.437599676029;4640.512746161655;4735.408073990751;4791.760411979404;4818.662693611449;4891.364122664048;4771.618270538349;4787.569118779309;4802.471728109905;4803.831865884695;4805.927911081337;4801.039792041588;4863.8297659582095;4873.098476781806;4874.707517548958;4880.023995200974;4160.83356665733;4168.103857670615;4168.937465938014;4172.457580514544;4177.10192308652;6090.5736598438125;6320.74717011319;6325.841853953642;6345.143405640226;6353.205849268841;5581.246531718207;5622.971885140548;5626.268585083953;5627.943720562783;5640.633358831663;5870.383609721003;6371.39471750183;6653.567518111307;6948.409385202264;7026.508144429892;3961.207758448293;4514.932276015862;4538.228501154812;4559.316102584606;4564.42944631921;5964.224650795369;7265.346118849276;7396.778096657002;7405.8889116663295;7420.4805663603565;4605.930911036337;4611.100835337077;4612.584867361954;4613.284940834176;4623.768811559408;4542.227821270392;4719.480857105716;4724.126036683225;4731.834385796481;4735.668503204743;4562.292844609091;4677.345171675968;5544.7227638618715;5612.214289999403;5619.550435965113;7100.68046937889;7103.680334384965;7106.7157313706875;7106.893396599055;7125.3230943060325;1578.0373971877145;1615.4991952494763;1637.6479057002803;1639.6146905477203;1645.4323258475806;1022.25375475903;1034.5086084109987;1042.635077722791;1046.4349251404155;1048.2138396202847;6339.904901426482;6441;6453.903191452132;6458.935410645833;6486.837829054311;7252.456065795086;7259.548090381839;7259.89110163348;7259.9274007259255;7265.7820265391065;6353.633968696752;6447.4197322241225;6454.128692626436;6454.677266136674;6456.709448074848;3858.5562660293863;3890.8638197662945;3915.7258991870294;3917.2361389529337;3918.2359439908946;7751.844963100706;7753.263439973193;7757.650905709256;7759.612019399007;7762.68949242024;7418.221086785809;7601.011868457065;7636.045494313211;7672.117706463717;7674.040744906887;6262;6982.825429364409;7675.347595454449;7685.346745526581;7699.191584883619;7090.858182836418;7176.677049532679;7286.344229019413;7312.268773122645;7373.741919032808;7226.530275532074;7240.565566066053;7251.456140789567;7259.854802903807;7263.455240856852;7383.261673832574;7622.31399174077;7722.38220942312;7727.304542591194;7728.381729461742;4753.595944344769;4811.879703007453;4812.5187481253;4827.227643577011;4828.95171048285;7161.391281740902;7182.928170718226;7184.425245980205;7231.204567497676;7262.527935684375;5918.757061017062;6051.0923361496125;6774.848275793225;7023.33278338557;7036.9296307036275;6514.609123452608;7049.365557099681;7056;7058.894116588358;7072.434205263669;5503.532199763065;6818.147731533559;6827.48793840454;6828.419584335387;6840.247572767091;6729.966350168218;6980.546264492792;7001.649917504206;7007.474439417166;7019.894701579378;6868.141482314711;6892.310768923067;6901.896471553031;6903.447724182154;6906.240313565403 00:02:17 INFO - PROCESS | 1958 | |5;yui.html;726.5313872552204;732.1763016606318;737.660676088999;747.3647399710247;778.9961050194748;17170.14149292535;17486.30054797808;17488.475345739615;17495.037772922486;17542.473725788248;15533.456329028486;15571.766423503657;15593.610159745984;15605.609859753511;15623.84376156238;689.4381079420282;705.6894966214875;789.8744289387629;858.2318824651933;870.7387783664907;607.3622696169027;672.4835495956611;696.5228818259483;698.1029377250235;698.552926127279;895.2166854002747;903.0833703790657;911.1480765484293;911.4075850697034;912.8813254276935;900.9774755631096;901.1664210605164;903.8327909336793;904.8235594059161;905.3119629081945;537.965032272901;546.8168163665177;660.5475249454139;665.9733610655568;670.2225418514499;14743.410263589443;15098;15102.471413500474;15146.621334466616;15160.545183644508;9998;12153.392330383534;12201.511939522408;12467;12660.303683297416;10053.447060411674;10143.442110683909;10234.846477302846;10329.380237185793;10867.619633312876;3467.2545402738533;3508.456189290664;3509.280597477511;3510.8420121094614;3517.103138699615;65696.67151664259;65940.67029664869;84526.15473845306;85826;86075.13924860797;7491.400687944952;9256.352055356061;9459;9607.279454040974;9864.062914023156;17372.13139343053;20152.29466968649;20630.968451577362;20639.793602063786;20658.79341206599;7126.964365178141;7233;7274.745383911538;7353.338199562065;7374.188839227681;4071.572484889103;4123;4124.793760311973;4133.090720041586;4144.109016561393;2860.485112679696;3437.553118094632;3444.0873168610337;3447.379471695119;3459.515667806509;608.6500262349167;620.9937900621027;627.4165026525375;638.0270088115568;645.0034696394082;541.6966498760706;602.6835911146683;609;625.7809766581751;626.3360837512251;8388.8741668875;8505.829883402297;8508.361872859436;8611.741647750578;8721.389502734748;501.4033300372545;525.2751203339367;600.945914867664;609.6524980760923;620.7734177025353;3057.29682173097;3897.922041559153;4341.565843415633;4372.956270437255;4381.978090109529;92000;92880;93641;93876.12247755006;100581;83740.58129709313;84113;84822;84942;85473.14526854652;65528.378864844875;65759.67120164368;66072.66963665151;66824.33175668182;69419.65290173618;8888;9027.368084234304;9034.45793252407;9034.683786067457;9208.12522810332;32963.835180823946;37036.44445333268;47736.761316193195;48326.75836620794;49826.501734983634;58421.415785843295;64261.39346516375;64441.67779161074;65449.67275163594;70520;10928.235023548275;11152.357082708131;11269.774604508028;11388.544458221579;11516.884831151581;11696.034475036908;11934.85562113709;11968.028295653996;12758.6172414824;12923.806142907675;11548.307101573933;11589.304641721523;11954.58158964432;11962;11965.581204658143;11196.272242304223;11383.089352851917;11754.529818807152;11787.587434439753;12195.939020304842;9418.62325506972;11283.492242849255;11642.24325418845;11658.53365865356;12077.51689932393;9259.398139120936;9266.814663706822;9342.813143737223;9568.665096721581;9606.471644059364;9193;9223.192299082051;9553.522323883917;9797.657082002095;9803.754906127404 00:02:17 INFO - PROCESS | 1958 | __end_tp_report 00:02:17 INFO - PROCESS | 1958 | __start_cc_report 00:02:17 INFO - PROCESS | 1958 | _x_x_mozilla_cycle_collect,1101 00:02:17 INFO - PROCESS | 1958 | __end_cc_report 00:02:17 INFO - PROCESS | 1958 | __startTimestamp1455177737725__endTimestamp 00:02:17 INFO - PROCESS | 1958 | 00:02:17 INFO - PROCESS | 1958 | ------- Summary: start ------- 00:02:17 INFO - PROCESS | 1958 | Number of tests: 6 00:02:17 INFO - PROCESS | 1958 | 00:02:17 INFO - PROCESS | 1958 | [#0] dojo.html Cycles:165 Average:5648.61 Median:5910.76 stddev:640.21 (10.8%) stddev-sans-first:606.47 00:02:17 INFO - PROCESS | 1958 | Values: 2961.4 3375.5 3433.9 3461.8 3476.9 5553.1 5630.6 5633.1 5640.8 5691.3 5640.1 5640.2 5742.4 5774.0 5824.4 5067.2 5108.5 5128.2 5137.2 5222.5 5173.4 5214.3 5241.4 5253.4 5281.8 5054.0 5123.0 5135.3 5141.8 5170.8 5105.6 5109.1 5117.0 5129.7 5163.0 5058.0 5083.9 5097.6 5118.4 5177.9 4608.7 5544.8 5546.3 5550.2 5673.9 6071.0 6141.9 6167.1 6171.5 6173.9 5507.0 6048.8 6115.5 6157.4 6249.0 5170.9 5599.5 5707.4 5764.8 5779.5 6186.7 6205.8 6213.6 6216.9 6233.7 5950.3 6037.7 6060.5 6089.0 6138.9 6158.6 6174.5 6177.0 6193.4 6200.4 6131.5 6133.6 6162.0 6171.2 6179.9 6022.2 6114.8 6132.3 6183.0 6228.0 4775.8 4780.1 4789.0 4815.4 4851.9 4306.7 4325.4 4334.3 4359.9 4423.8 5470.2 5507.7 5509.4 5531.3 5549.8 6126.7 6147.2 6170.4 6193.8 6195.5 5563.9 5575.2 5582.5 5594.7 5614.0 5290.6 5312.8 5320.7 5335.9 5390.3 6101.8 6211.9 6217.1 6251.7 6272.6 6081.2 6129.3 6133.3 6134.4 6140.1 6174.7 6188.8 6204.2 6210.0 6217.8 6000.4 6087.2 6101.4 6105.4 6116.5 6129.1 6137.1 6143.8 6145.6 6194.2 6028.5 6028.7 6031.8 6034.1 6082.7 5900.1 5949.6 6000.7 6070.2 6081.8 5699.9 5780.9 5856.5 5910.8 5966.7 4744.4 6033.3 6041.0 6065.9 6111.2 5789.6 5911.6 5918.3 5919.9 5949.6 00:02:17 INFO - PROCESS | 1958 | 00:02:17 INFO - PROCESS | 1958 | [#1] ext.html Cycles:180 Average:62393.23 Median:39138.61 stddev:131157.07 (335.1%) stddev-sans-first:131442.56 00:02:17 INFO - PROCESS | 1958 | Values: 454.1 466.1 470.2 488.8 556.8 29125.3 29643.4 37528.0 37699.8 37719.8 40032.0 40345.6 40362.6 40496.6 40504.0 7660.5 9441.3 9652.7 9656.0 9674.9 9528.8 9680.0 9680.3 9685.7 9704.6 9757.2 9813.7 9819.7 9823.9 9827.5 9707.7 9719.8 9749.1 9808.4 9809.8 8148.8 9697.0 9719.5 9727.8 9732.5 38889.0 39117.2 39160.0 39203.0 39203.6 2796.0 3157.4 3246.5 3435.7 3754.5 28171.0 28346.3 28418.9 29015.9 29656.7 2378.7 2671.4 2808.3 2827.2 2883.1 464821.0 467406.7 467428.0 467928.0 468165.3 62364.7 62447.7 62623.0 62854.1 62915.0 66198.3 66348.7 66433.0 66475.7 66478.7 16606.6 16793.5 16846.2 16864.0 16870.7 11696.2 12126.7 12763.8 12843.8 12859.0 17951.9 18907.9 19403.0 19611.6 19676.3 6511.3 7645.2 7735.3 7752.7 7835.5 931.6 971.7 977.4 1073.4 1074.9 23551.6 27708.3 28163.6 28244.3 28733.3 917.8 987.6 989.2 1080.8 1087.4 13984.2 14054.4 14112.2 14174.6 14179.6 437370.0 442586.8 554997.0 656707.0 661474.0 49173.0 49265.0 49989.8 50112.2 50137.0 1429.0 1433.5 1454.4 1455.1 1457.9 23019.5 27631.4 29043.9 29688.4 30343.4 50033.0 50604.5 50653.5 50726.2 50779.5 439892.0 442186.0 442245.0 442762.0 443379.0 28973.0 30147.6 30149.6 30164.5 30196.5 42275.9 43013.9 43787.6 43916.8 44601.6 32340.0 33590.0 34588.8 34748.8 35361.5 33619.0 33973.5 34201.8 35079.8 35238.8 34724.0 34990.5 34995.0 35802.6 36245.8 29505.0 29588.1 31122.8 31203.0 31233.8 18591.7 23749.5 24595.4 25189.6 25799.0 00:02:17 INFO - PROCESS | 1958 | 00:02:17 INFO - PROCESS | 1958 | [#2] jquery.html Cycles:180 Average:34671.98 Median:400.63 stddev:111491.44 (27829.3%) stddev-sans-first:111774.43 00:02:17 INFO - PROCESS | 1958 | Values: 359.8 361.8 367.4 371.5 374.4 14836.7 15154.9 18542.7 18716.5 19504.0 11393.1 11666.0 11667.4 12042.5 18430.8 5212.7 5403.9 5403.9 5405.6 5414.9 3872.7 4090.6 4725.5 5706.1 5929.1 5653.6 5821.1 5845.1 5879.9 5896.9 5653.6 5746.8 5789.0 5792.7 5801.1 5507.4 5520.3 5672.2 5687.6 5698.1 22693.0 22863.9 23572.0 23801.6 23868.5 2262.6 2353.6 2461.8 2531.3 2789.1 7454.4 9556.3 9559.0 9954.7 9978.1 1747.4 1750.1 1780.5 1794.1 1827.3 92731.0 97043.5 97167.0 97765.5 98681.5 10606.2 10799.1 10828.5 10843.6 10916.2 13015.0 13259.9 13286.7 13298.7 13301.7 6817.6 8274.9 8289.6 8378.4 8394.6 8350.7 8377.8 8386.4 8484.7 8499.7 3906.9 4103.4 4233.5 4339.9 4396.8 1790.2 1834.8 1843.6 1859.1 1877.5 399.3 402.0 867.6 915.3 978.2 11232.6 11275.2 11506.5 11765.0 11805.8 894.0 922.9 975.1 1013.8 1038.8 9269.6 9954.0 9966.4 10129.7 10209.2 477772.7 699510.0 705121.0 719161.0 736826.0 114354.0 116421.0 121146.0 121309.0 122394.4 1055.4 1145.2 1166.5 1201.0 1208.9 12750.4 16865.6 17116.3 17261.4 17663.6 46856.3 46965.8 47044.0 47058.3 47774.5 67813.3 67845.3 68299.0 68311.7 68445.3 7106.8 7409.3 7478.0 7484.4 7570.5 9770.0 11621.1 11690.7 11878.8 12068.5 9702.9 9868.9 10313.4 10317.3 10416.6 9883.7 10361.0 10415.2 10418.4 10421.0 8684.3 10041.8 10507.6 10676.8 10795.8 7517.9 7680.7 7689.3 7704.6 7727.8 8404.2 10215.5 10597.2 10814.6 10815.2 00:02:17 INFO - PROCESS | 1958 | 00:02:17 INFO - PROCESS | 1958 | [#3] mootools.html Cycles:180 Average:5999.46 Median:5153.96 stddev:3132.30 (60.8%) stddev-sans-first:3121.22 00:02:17 INFO - PROCESS | 1958 | Values: 1307.5 1396.5 1533.3 1709.8 1922.2 7788.1 8386.8 8551.6 8552.3 8558.3 8264.9 8503.4 8512.7 8519.5 8522.3 2161.4 2207.1 2225.3 2467.1 2500.0 2237.7 2240.9 2243.2 2456.9 2511.8 2432.1 2458.8 2459.7 2459.8 2465.9 2446.8 2476.0 2477.6 2483.8 2486.2 2450.6 2474.2 2475.5 2475.8 2478.8 8540.7 8619.7 8632.2 8634.1 8645.1 5315.9 5430.2 5474.4 5479.4 5479.7 3641.1 3650.2 3735.5 3742.3 3744.5 1067.4 1068.1 1094.6 1107.6 1110.1 11568.5 11757.6 11759.4 11762.6 11773.6 4348.2 4797.6 4828.1 4909.1 4992.1 10069.6 10083.6 10099.9 10100.2 10100.5 4595.8 5441.1 5471.2 5484.8 5486.5 4935.7 4978.3 4982.6 4984.7 4989.2 3699.9 3815.8 3855.1 3897.1 3918.8 1237.7 1329.4 1348.2 1350.3 1356.9 1296.8 1305.4 1307.5 1335.5 1360.1 7781.0 7938.1 7944.1 7982.3 7982.8 1148.6 1173.5 1173.8 1193.9 1201.5 6128.4 6212.9 6231.6 6241.7 6249.5 10433.9 10476.6 10519.3 10553.4 10647.1 10397.9 10489.9 10510.9 10541.0 10556.2 7923.5 8262.2 8332.3 8335.7 8351.0 7771.2 7827.4 7851.1 7861.5 7865.8 9212.4 9582.9 9583.7 9597.0 9702.5 9530.0 9733.0 9889.7 9956.7 9996.5 7444.9 7509.2 7517.4 7522.0 7530.0 7391.4 7563.9 7795.4 8078.6 8107.1 6825.9 7093.7 7490.0 7639.8 7782.3 7305.4 7339.2 7534.8 7563.7 7579.4 7372.3 7601.9 7708.5 7746.9 7748.0 5830.3 6968.2 6983.6 6991.5 6998.0 6809.6 7078.0 7109.0 7121.8 7135.2 00:02:17 INFO - PROCESS | 1958 | 00:02:17 INFO - PROCESS | 1958 | [#4] prototype.html Cycles:180 Average:5721.09 Median:6431.87 stddev:1827.92 (28.4%) stddev-sans-first:1787.56 00:02:17 INFO - PROCESS | 1958 | Values: 321.9 327.2 332.3 335.3 341.5 6500.9 6584.0 6652.9 6695.0 6707.6 6419.2 6422.7 6601.9 6602.5 6604.4 4882.4 4882.7 4885.4 4887.6 4890.4 4640.5 4735.4 4791.8 4818.7 4891.4 4771.6 4787.6 4802.5 4803.8 4805.9 4801.0 4863.8 4873.1 4874.7 4880.0 4160.8 4168.1 4168.9 4172.5 4177.1 6090.6 6320.7 6325.8 6345.1 6353.2 5581.2 5623.0 5626.3 5627.9 5640.6 5870.4 6371.4 6653.6 6948.4 7026.5 3961.2 4514.9 4538.2 4559.3 4564.4 5964.2 7265.3 7396.8 7405.9 7420.5 4605.9 4611.1 4612.6 4613.3 4623.8 4542.2 4719.5 4724.1 4731.8 4735.7 4562.3 4677.3 5544.7 5612.2 5619.6 7100.7 7103.7 7106.7 7106.9 7125.3 1578.0 1615.5 1637.6 1639.6 1645.4 1022.3 1034.5 1042.6 1046.4 1048.2 6339.9 6441.0 6453.9 6458.9 6486.8 7252.5 7259.5 7259.9 7259.9 7265.8 6353.6 6447.4 6454.1 6454.7 6456.7 3858.6 3890.9 3915.7 3917.2 3918.2 7751.8 7753.3 7757.7 7759.6 7762.7 7418.2 7601.0 7636.0 7672.1 7674.0 6262.0 6982.8 7675.3 7685.3 7699.2 7090.9 7176.7 7286.3 7312.3 7373.7 7226.5 7240.6 7251.5 7259.9 7263.5 7383.3 7622.3 7722.4 7727.3 7728.4 4753.6 4811.9 4812.5 4827.2 4829.0 7161.4 7182.9 7184.4 7231.2 7262.5 5918.8 6051.1 6774.8 7023.3 7036.9 6514.6 7049.4 7056.0 7058.9 7072.4 5503.5 6818.1 6827.5 6828.4 6840.2 6730.0 6980.5 7001.6 7007.5 7019.9 6868.1 6892.3 6901.9 6903.4 6906.2 00:02:17 INFO - PROCESS | 1958 | 00:02:17 INFO - PROCESS | 1958 | [#5] yui.html Cycles:180 Average:18167.45 Median:615.21 stddev:25642.52 (4168.1%) stddev-sans-first:25681.01 00:02:17 INFO - PROCESS | 1958 | Values: 726.5 732.2 737.7 747.4 779.0 17170.1 17486.3 17488.5 17495.0 17542.5 15533.5 15571.8 15593.6 15605.6 15623.8 689.4 705.7 789.9 858.2 870.7 607.4 672.5 696.5 698.1 698.6 895.2 903.1 911.1 911.4 912.9 901.0 901.2 903.8 904.8 905.3 538.0 546.8 660.5 666.0 670.2 14743.4 15098.0 15102.5 15146.6 15160.5 9998.0 12153.4 12201.5 12467.0 12660.3 10053.4 10143.4 10234.8 10329.4 10867.6 3467.3 3508.5 3509.3 3510.8 3517.1 65696.7 65940.7 84526.2 85826.0 86075.1 7491.4 9256.4 9459.0 9607.3 9864.1 17372.1 20152.3 20631.0 20639.8 20658.8 7127.0 7233.0 7274.7 7353.3 7374.2 4071.6 4123.0 4124.8 4133.1 4144.1 2860.5 3437.6 3444.1 3447.4 3459.5 608.7 621.0 627.4 638.0 645.0 541.7 602.7 609.0 625.8 626.3 8388.9 8505.8 8508.4 8611.7 8721.4 501.4 525.3 600.9 609.7 620.8 3057.3 3897.9 4341.6 4373.0 4382.0 92000.0 92880.0 93641.0 93876.1 100581.0 83740.6 84113.0 84822.0 84942.0 85473.1 65528.4 65759.7 66072.7 66824.3 69419.7 8888.0 9027.4 9034.5 9034.7 9208.1 32963.8 37036.4 47736.8 48326.8 49826.5 58421.4 64261.4 64441.7 65449.7 70520.0 10928.2 11152.4 11269.8 11388.5 11516.9 11696.0 11934.9 11968.0 12758.6 12923.8 11548.3 11589.3 11954.6 11962.0 11965.6 11196.3 11383.1 11754.5 11787.6 12195.9 9418.6 11283.5 11642.2 11658.5 12077.5 9259.4 9266.8 9342.8 9568.7 9606.5 9193.0 9223.2 9553.5 9797.7 9803.8 00:02:17 INFO - PROCESS | 1958 | -------- Summary: end -------- 00:02:17 INFO - PROCESS | 1958 | 00:02:18 INFO - TEST-INFO | 1958: exit 0 00:02:18 INFO - TEST-OK | dromaeo_css | took 1114392ms 00:02:18 INFO - TEST-START | kraken 00:02:18 INFO - operating with platform_type : mac_ 00:02:18 INFO - Initialising browser for kraken test... 00:02:18 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpLpnECa/profile http://localhost:49452/getInfo.html) 00:02:20 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 00:02:20 INFO - PROCESS | 1965 | colorDepth:24 00:02:20 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 00:02:20 INFO - PROCESS | 1965 | __metrics 00:02:20 INFO - PROCESS | 1965 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:02:20 INFO - PROCESS | 1965 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:02:21 INFO - TEST-INFO | 1965: exit 0 00:02:21 INFO - Browser initialized. 00:02:21 INFO - Running cycle 1/1 for kraken test... 00:02:21 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpLpnECa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:02:33 INFO - PROCESS | 1967 | RSS: Main: 246886400 00:02:33 INFO - PROCESS | 1967 | 00:02:35 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49452/tests/kraken/driver.html?testName=audio-beat-detection) 00:02:36 INFO - PROCESS | 1967 | RSS: Main: 292179968 00:02:36 INFO - PROCESS | 1967 | 00:02:38 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49452/tests/kraken/driver.html?testName=audio-dft) 00:02:39 INFO - PROCESS | 1967 | RSS: Main: 302403584 00:02:39 INFO - PROCESS | 1967 | 00:02:42 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49452/tests/kraken/driver.html?testName=audio-fft) 00:02:43 INFO - PROCESS | 1967 | RSS: Main: 285081600 00:02:43 INFO - PROCESS | 1967 | 00:02:45 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49452/tests/kraken/driver.html?testName=audio-oscillator) 00:02:45 INFO - PROCESS | 1967 | RSS: Main: 287461376 00:02:45 INFO - PROCESS | 1967 | 00:02:47 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49452/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:02:48 INFO - PROCESS | 1967 | RSS: Main: 288841728 00:02:48 INFO - PROCESS | 1967 | 00:02:51 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49452/tests/kraken/driver.html?testName=imaging-darkroom) 00:02:51 INFO - PROCESS | 1967 | RSS: Main: 290803712 00:02:51 INFO - PROCESS | 1967 | 00:02:54 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49452/tests/kraken/driver.html?testName=imaging-desaturate) 00:02:55 INFO - PROCESS | 1967 | RSS: Main: 289644544 00:02:55 INFO - PROCESS | 1967 | 00:02:57 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49452/tests/kraken/driver.html?testName=json-parse-financial) 00:02:58 INFO - PROCESS | 1967 | RSS: Main: 291151872 00:02:58 INFO - PROCESS | 1967 | 00:03:00 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49452/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:03:00 INFO - PROCESS | 1967 | RSS: Main: 325369856 00:03:00 INFO - PROCESS | 1967 | 00:03:02 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:03:03 INFO - PROCESS | 1967 | RSS: Main: 325124096 00:03:03 INFO - PROCESS | 1967 | 00:03:05 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:03:05 INFO - PROCESS | 1967 | RSS: Main: 334229504 00:03:05 INFO - PROCESS | 1967 | 00:03:08 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:03:09 INFO - PROCESS | 1967 | RSS: Main: 334630912 00:03:09 INFO - PROCESS | 1967 | 00:03:11 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:03:12 INFO - PROCESS | 1967 | RSS: Main: 335486976 00:03:12 INFO - PROCESS | 1967 | 00:03:13 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49452/tests/kraken/driver.html?testName=ai-astar) 00:03:14 INFO - PROCESS | 1967 | RSS: Main: 396038144 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | __start_tp_report 00:03:14 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 00:03:14 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 00:03:14 INFO - PROCESS | 1967 | |i|pagename|runs| 00:03:14 INFO - PROCESS | 1967 | |0;ai-astar;110;111;110;107;111;112;118;111;111;110 00:03:14 INFO - PROCESS | 1967 | |1;audio-beat-detection;158;124;142;156;120;150;161;146;160;120 00:03:14 INFO - PROCESS | 1967 | |2;audio-dft;185;184;188;187;186;185;184;183;181;183 00:03:14 INFO - PROCESS | 1967 | |3;audio-fft;73;75;87;77;57;58;61;87;100;68 00:03:14 INFO - PROCESS | 1967 | |4;audio-oscillator;94;94;124;78;80;83;110;76;78;112 00:03:14 INFO - PROCESS | 1967 | |5;imaging-gaussian-blur;87;89;84;91;85;91;92;91;85;92 00:03:14 INFO - PROCESS | 1967 | |6;imaging-darkroom;94;94;94;94;94;94;94;94;94;93 00:03:14 INFO - PROCESS | 1967 | |7;imaging-desaturate;85;85;87;86;87;85;86;84;87;87 00:03:14 INFO - PROCESS | 1967 | |8;json-parse-financial;55;52;51;49;52;55;53;64;53;54 00:03:14 INFO - PROCESS | 1967 | |9;json-stringify-tinderbox;63;63;67;77;67;70;67;67;68;67 00:03:14 INFO - PROCESS | 1967 | |10;stanford-crypto-aes;83;83;84;84;95;109;106;106;83;84 00:03:14 INFO - PROCESS | 1967 | |11;stanford-crypto-ccm;125;125;129;127;122;132;126;126;123;124 00:03:14 INFO - PROCESS | 1967 | |12;stanford-crypto-pbkdf2;126;129;138;137;139;127;139;137;137;137 00:03:14 INFO - PROCESS | 1967 | |13;stanford-crypto-sha256-iterative;65;65;66;66;67;67;67;67;67;65 00:03:14 INFO - PROCESS | 1967 | __end_tp_report 00:03:14 INFO - PROCESS | 1967 | __start_cc_report 00:03:14 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,1199 00:03:14 INFO - PROCESS | 1967 | __end_cc_report 00:03:14 INFO - PROCESS | 1967 | __startTimestamp1455177794037__endTimestamp 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | ------- Summary: start ------- 00:03:14 INFO - PROCESS | 1967 | Number of tests: 14 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:2.77 (2.5%) stddev-sans-first:2.91 00:03:14 INFO - PROCESS | 1967 | Values: 110.0 111.0 110.0 107.0 111.0 112.0 118.0 111.0 111.0 110.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:153.00 stddev:16.60 (10.8%) stddev-sans-first:16.78 00:03:14 INFO - PROCESS | 1967 | Values: 158.0 124.0 142.0 156.0 120.0 150.0 161.0 146.0 160.0 120.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.00 stddev:2.07 (1.1%) stddev-sans-first:2.19 00:03:14 INFO - PROCESS | 1967 | Values: 185.0 184.0 188.0 187.0 186.0 185.0 184.0 183.0 181.0 183.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#3] audio-fft Cycles:10 Average:74.30 Median:74.00 stddev:14.04 (19.0%) stddev-sans-first:14.88 00:03:14 INFO - PROCESS | 1967 | Values: 73.0 75.0 87.0 77.0 57.0 58.0 61.0 87.0 100.0 68.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:79.00 stddev:17.06 (21.6%) stddev-sans-first:18.10 00:03:14 INFO - PROCESS | 1967 | Values: 94.0 94.0 124.0 78.0 80.0 83.0 110.0 76.0 78.0 112.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:91.00 stddev:3.16 (3.5%) stddev-sans-first:3.30 00:03:14 INFO - PROCESS | 1967 | Values: 87.0 89.0 84.0 91.0 85.0 91.0 92.0 91.0 85.0 92.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:03:14 INFO - PROCESS | 1967 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.50 stddev:1.10 (1.3%) stddev-sans-first:1.12 00:03:14 INFO - PROCESS | 1967 | Values: 85.0 85.0 87.0 86.0 87.0 85.0 86.0 84.0 87.0 87.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.50 stddev:4.02 (7.5%) stddev-sans-first:4.24 00:03:14 INFO - PROCESS | 1967 | Values: 55.0 52.0 51.0 49.0 52.0 55.0 53.0 64.0 53.0 54.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.00 stddev:3.92 (5.9%) stddev-sans-first:3.79 00:03:14 INFO - PROCESS | 1967 | Values: 63.0 63.0 67.0 77.0 67.0 70.0 67.0 67.0 68.0 67.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:83.50 stddev:11.18 (13.4%) stddev-sans-first:11.40 00:03:14 INFO - PROCESS | 1967 | Values: 83.0 83.0 84.0 84.0 95.0 109.0 106.0 106.0 83.0 84.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:126.00 stddev:2.92 (2.3%) stddev-sans-first:3.08 00:03:14 INFO - PROCESS | 1967 | Values: 125.0 125.0 129.0 127.0 122.0 132.0 126.0 126.0 123.0 124.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.60 Median:137.00 stddev:5.13 (3.7%) stddev-sans-first:4.39 00:03:14 INFO - PROCESS | 1967 | Values: 126.0 129.0 138.0 137.0 139.0 127.0 139.0 137.0 137.0 137.0 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - PROCESS | 1967 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 00:03:14 INFO - PROCESS | 1967 | Values: 65.0 65.0 66.0 66.0 67.0 67.0 67.0 67.0 67.0 65.0 00:03:14 INFO - PROCESS | 1967 | -------- Summary: end -------- 00:03:14 INFO - PROCESS | 1967 | 00:03:14 INFO - TEST-INFO | 1967: exit 0 00:03:14 INFO - TEST-OK | kraken | took 56525ms 00:03:14 INFO - SUITE-END | took 1170s 00:03:15 INFO - Completed test suite (00:19:31) 00:03:15 INFO - Working with test: dromaeo_css 00:03:15 INFO - Generating results file: dromaeo_css 00:03:15 INFO - Working with test: kraken 00:03:15 INFO - Generating results file: kraken 00:03:15 INFO - javascript benchmark 00:03:15 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:03:15 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 00:03:15 INFO - process_Request line: dromaeo_css 7362.81 graph.html#tests=[[72,64,59]] 00:03:15 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:03:15 INFO - process_Request line: kraken 1414.90 graph.html#tests=[[232,64,59]] 00:03:15 INFO - RETURN: dromaeo_css: 7362.81 00:03:15 INFO - RETURN: kraken: 1414.90 00:03:15 INFO - javascript benchmark 00:03:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2961.3929144525373, 3375.5274261603377, 3433.8626454941805, 3461.792292462451, 3476.91307717307, 5553.08374118271, 5630.634008789431, 5633.070543360346, 5640.7590330127405, 5691.260136182295, 5640.0693885508945, 5640.238567793347, 5742.425757424256, 5774.018416869132, 5824.446677565635, 5067.189249720045, 5108.540231379176, 5128.153854613985, 5137.2037334213255, 5222.529972302492, 5173.430922598511, 5214.322138122039, 5241.42344342122, 5253.369595648527, 5281.788728450857, 5054.039732450841, 5123.026624941286, 5135.255387968761, 5141.845744627667, 5170.819021334254, 5105.566026887682, 5109.105906466353, 5117.0, 5129.743512824344, 5163.0190263849745, 5057.974710126463, 5083.872903177413, 5097.643164978453, 5118.411382691001, 5177.922331165036, 4608.654350923661, 5544.833654990357, 5546.306711661043, 5550.195221692832, 5673.886522269531, 6070.969645151746, 6141.938580614182, 6167.105769663373, 6171.506279497674, 6173.9073913891325, 5506.972465137689, 6048.848778780522, 6115.544587952024, 6157.4458298753325, 6248.968755156195, 5170.922436163461, 5599.496045355897, 5707.429257074259, 5764.827055188267, 5779.450952159538, 6186.721597528122, 6205.81382558524, 6213.596116252519, 6216.937830621727, 6233.688315584293, 5950.285965684146, 6037.667928263988, 6060.484858786965, 6089.025755879038, 6138.907916381258, 6158.568900177034, 6174.536909731698, 6176.969115154486, 6193.4425901669065, 6200.3799620038535, 6131.50947924165, 6133.601315914451, 6162.0, 6171.228596425447, 6179.876402471926, 6022.18700475439, 6114.814446323802, 6132.294786099566, 6183.0107182850525, 6227.96886015567, 4775.808967641256, 4780.11567859947, 4789.0, 4815.374001379868, 4851.902961940741, 4306.698531102793, 4325.351197320427, 4334.28484300087, 4359.934600980988, 4423.756693381831, 5470.234167216593, 5507.669539827543, 5509.421510741315, 5531.3362396511875, 5549.805756798492, 6126.670355029888, 6147.231596050494, 6170.444659980623, 6193.81418557435, 6195.504359651217, 5563.888722225533, 5575.247341608912, 5582.525485333711, 5594.692291923983, 5614.045612245928, 5290.576753859682, 5312.814051508256, 5320.707361095099, 5335.919961200585, 5390.299261096111, 6101.82280290701, 6211.875762484816, 6217.067439883963, 6251.718672659741, 6272.560920735687, 6081.209063992285, 6129.325774164749, 6133.26400831903, 6134.4172303631085, 6140.140380346845, 6174.66039367839, 6188.81433556994, 6204.224471941007, 6210.0, 6217.844553886189, 6000.399960003964, 6087.208662873798, 6101.389861013863, 6105.389461053859, 6116.510679145568, 6129.053167990421, 6137.101203255209, 6143.84640383994, 6145.555794388226, 6194.194754681863, 6028.547858910511, 6028.728707208098, 6031.7587296507645, 6034.064719968412, 6082.72627731762, 5900.144479050599, 5949.6430214187285, 6000.729967151401, 6070.2412198475195, 6081.756729730761, 5699.945510080483, 5780.855478613068, 5856.531477481876, 5910.763569457174, 5966.67183304905, 4744.430668319824, 6033.276006879202, 6041.0, 6065.939340606537, 6111.205543279345, 5789.623674461147, 5911.615744976562, 5918.3489816121055, 5919.91120133207, 5949.553783466171], "unit": "score", "name": "dojo.html", "value": 5607.9818324126645}, {"lowerIsBetter": false, "replicates": [454.12580781994654, 466.1213612340739, 470.18188352267066, 488.7556221889055, 556.799552161222, 29125.27186820328, 29643.40713185735, 37528.0, 37699.81150094246, 37719.811400942956, 40032.0, 40345.59654403455, 40362.59637403625, 40496.59503404965, 40504.0, 7660.502067365631, 9441.291903107278, 9652.662156824512, 9655.951720241388, 9674.90325096747, 9528.809423811519, 9680.031996800333, 9680.273979451535, 9685.70942871715, 9704.563294651758, 9757.219422446222, 9813.65652202173, 9819.656312029081, 9823.901760982406, 9827.459489728062, 9707.66023189185, 9719.805603887953, 9749.122578967892, 9808.411495310304, 9809.803803923916, 8148.796280092985, 9696.95151524238, 9719.46542940138, 9727.805443891153, 9732.513374331325, 38889.0, 39117.21765564673, 39160.0, 39203.0, 39203.60796392028, 2795.9580606290924, 3157.431662300785, 3246.4643333849885, 3435.7423193260606, 3754.4743735877, 28171.014014509597, 28346.2913427166, 28418.863245470155, 29015.85492072526, 29656.703432965827, 2378.7383387827326, 2671.412289296352, 2808.311963568918, 2827.1801177658454, 2883.0774152271283, 464821.0, 467406.6629666864, 467428.0, 467927.9999999966, 468165.3183468156, 62364.688176558826, 62447.687761560905, 62623.0, 62854.0571891422, 62915.0, 66198.33801662018, 66348.6682566584, 66433.0, 66475.66762166159, 66478.66760666166, 16606.584835379213, 16793.496195114167, 16846.24191911367, 16864.0, 16870.746938795928, 11696.239744416585, 12126.696832579257, 12763.808542871864, 12843.807342889864, 12859.035572332112, 17951.910240448713, 18907.86552806836, 19403.0, 19611.60776784456, 19676.3113291037, 6511.316311787289, 7645.235476452311, 7735.3424958878, 7752.728654497066, 7835.49069310493, 931.5621657820814, 971.708487453761, 977.359829311802, 1073.4096247064083, 1074.9301295415773, 23551.593421353573, 27708.30729231785, 28163.577546336823, 28244.293892652848, 28733.28166795805, 917.7613820406609, 987.6345752071779, 989.1987490133015, 1080.8162612355918, 1087.429099722636, 13984.160950343012, 14054.43782248719, 14112.153270803785, 14174.574762757135, 14179.645508862155, 437370.0, 442586.787066069, 554997.0, 656707.0, 661474.0, 49173.0, 49265.014699705804, 49989.75005125024, 50112.24831627528, 50136.997260054595, 1429.028260782657, 1433.4624515806572, 1454.3964254834125, 1455.1196526101767, 1457.8615031571771, 23019.539609208055, 27631.447371052065, 29043.85478072596, 29688.406231875673, 30343.393132137677, 50033.0, 50604.49395505998, 50653.49346506635, 50726.23910641269, 50779.492205078954, 439892.0, 442186.0, 442245.0, 442762.0, 443379.0, 28972.985945491808, 30147.64335604947, 30149.64326605264, 30164.54753178748, 30196.54705179468, 42275.94310142271, 43013.92465188395, 43787.56212437962, 43916.78041609899, 44601.55398445974, 32340.0, 33589.99230023103, 34588.827055865564, 34748.82625586856, 35361.469577956865, 33619.0, 33973.49039764455, 34201.82899085488, 35079.82460087785, 35238.823805880806, 34724.0, 34990.47514287237, 34995.0, 35802.641973580976, 36245.81877090598, 29505.0, 29588.112356629335, 31122.844385778833, 31203.0, 31233.8438307807, 18591.721124182877, 23749.52500950006, 24595.4401431327, 25189.62215566731, 25798.968041278138], "unit": "score", "name": "ext.html", "value": 19050.836052233186}, {"lowerIsBetter": false, "replicates": [359.77693829825506, 361.761237583195, 367.39196629578043, 371.5003320533881, 374.38040043727625, 14836.703265934675, 15154.924225378858, 18542.721859172107, 18716.53208669782, 19504.024798760078, 11393.088552915768, 11666.008389286899, 11667.358295293756, 12042.518299268018, 18430.815691843076, 5212.687238765668, 5403.891922161554, 5403.945960540404, 5405.621606487547, 5414.8917021659545, 3872.7289089763726, 4090.5909409059004, 4725.527447255281, 5706.087026075828, 5929.080992446177, 5653.575981801361, 5821.068629019358, 5845.123231515286, 5879.911801322984, 5896.911546326808, 5653.604247702662, 5746.770129194827, 5789.0, 5792.68140252286, 5801.071828507418, 5507.449255074501, 5520.309961254843, 5672.205891175238, 5687.601867869251, 5698.088305871041, 22692.97881595332, 22863.88568057149, 23572.0, 23801.642975355382, 23868.522629547486, 2262.558801033799, 2353.5645905507363, 2461.778439940396, 2531.291238453236, 2789.0517224143887, 7454.40364770817, 9556.283278754052, 9558.996305387904, 9954.651587194487, 9978.101970822661, 1747.3622127923215, 1750.0549703160277, 1780.5459607799928, 1794.1119146022672, 1827.259959716317, 92731.03482661508, 97043.51478242634, 97167.0283297165, 97765.5111724451, 98681.5197772034, 10606.204534659932, 10799.082078023299, 10828.512716927757, 10843.566257349776, 10916.235863489639, 13015.023873209548, 13259.867401326057, 13286.734265314639, 13298.73402531944, 13301.73396532064, 6817.556858804261, 8274.875876861732, 8289.626966786389, 8378.371622128243, 8394.580270986426, 8350.749477515685, 8377.790555236168, 8386.371022173362, 8484.660613575512, 8499.74500764978, 3906.941395879064, 4103.4050062741335, 4233.534311225824, 4339.934900976488, 4396.846110386121, 1790.1675720789895, 1834.7523084383438, 1843.5759775251768, 1859.1169194632712, 1877.5118469197835, 399.25339614919704, 401.99799001004806, 867.6399294292924, 915.3089417489753, 978.217426059164, 11232.550697972152, 11275.154363422776, 11506.482208300647, 11764.99997500222, 11805.822912656316, 893.9508327041945, 922.898481167071, 975.1029053271008, 1013.8175128476945, 1038.766277587552, 9269.582868770787, 9953.954834742393, 9966.40201587907, 10129.69610911659, 10209.234307426972, 477772.67141558684, 699510.0, 705121.0, 719161.0, 736826.0, 114354.0, 116421.0, 121146.0, 121309.0, 122394.38802805929, 1055.3509591601264, 1145.2212495503138, 1166.5450474315023, 1201.0151675626078, 1208.8851559101872, 12750.426230819821, 16865.578360541083, 17116.315347385964, 17261.39585114515, 17663.64672706513, 46856.297155542015, 46965.76517117392, 47044.0, 47058.29412558883, 47774.5222547784, 67813.32186678267, 67845.3215467839, 68299.0, 68311.65844170748, 68445.31554684389, 7106.786796396116, 7409.259074092548, 7478.0, 7484.401247900264, 7570.545767253982, 9769.951150244204, 11621.070314375, 11690.70773230676, 11878.762424751629, 12068.456919438822, 9702.85445718329, 9868.85196722064, 10313.381197128196, 10317.329373590992, 10416.635417760343, 9883.654072107442, 10361.0, 10415.218858585486, 10418.426986515815, 10421.0, 8684.305255579664, 10041.845187803496, 10507.579696812347, 10676.786464270826, 10795.784084318113, 7517.933142845707, 7680.692772289046, 7689.307962283421, 7704.614769261627, 7727.845443091219, 8404.20160084791, 10215.540300686338, 10597.205209609465, 10814.621488247874, 10815.24293299493], "unit": "score", "name": "jquery.html", "value": 8729.634390031346}, {"lowerIsBetter": false, "replicates": [1307.5162189989703, 1396.4623619906333, 1533.2640332640335, 1709.7948246210449, 1922.221500292382, 7788.104367997682, 8386.790330241747, 8551.572421378922, 8552.27305679018, 8558.315334773226, 8264.876026859587, 8503.447275927061, 8512.659493620264, 8519.53142577158, 8522.318214542836, 2161.448830548208, 2207.0840601150503, 2225.321277010519, 2467.1488336523917, 2500.0249902538026, 2237.7202849643795, 2240.9215677451293, 2243.2148747938254, 2456.91400800972, 2511.7864981476596, 2432.1487479382254, 2458.7787099161073, 2459.667944827452, 2459.8032157427365, 2465.8890349934204, 2446.779789818907, 2476.0467220120204, 2477.578811602032, 2483.788877945377, 2486.167134010109, 2450.644656524794, 2474.1711526638596, 2475.480149168659, 2475.8143139264625, 2478.7893029092547, 8540.70107546233, 8619.741407757778, 8632.223099921037, 8634.050254472004, 8645.092265312114, 5315.867103322409, 5430.1537477257925, 5474.370447398521, 5479.369872464637, 5479.671219726829, 3641.1443310821937, 3650.18935419728, 3735.5143831301757, 3742.270257299828, 3744.5132132822832, 1067.3542506783363, 1068.1081297116916, 1094.5840580579409, 1107.617871834224, 1110.0509064749683, 11568.479418426192, 11757.647270581896, 11759.35323557204, 11762.647120586482, 11773.587924422603, 4348.152110338454, 4797.6326746876975, 4828.106800241966, 4909.116359055333, 4992.05151021312, 10069.647562335284, 10083.647072352433, 10099.94950025245, 10100.191984641211, 10100.545475453475, 4595.816167353335, 5441.075017247077, 5471.206675032098, 5484.808031718871, 5486.451354864482, 4935.679180853233, 4978.27814966835, 4982.626303027288, 4984.651074424755, 4989.151844186497, 3699.8705045323823, 3815.8473661053804, 3855.055511399669, 3897.0647044709067, 3918.764874107506, 1237.6843904804218, 1329.415057374752, 1348.2449828096298, 1350.257358452847, 1356.85752995936, 1296.8378952630922, 1305.3995162225483, 1307.5358247821887, 1335.4858379523953, 1360.1363134409721, 7780.961095194601, 7938.126806051329, 7944.126146123922, 7982.281594656509, 7982.800429989296, 1148.6094727792424, 1173.4602083041725, 1173.841531393268, 1193.91045671575, 1201.4533387308754, 6128.448439640454, 6212.875742485125, 6231.563790534619, 6241.687915604292, 6249.500039996789, 10433.947830260951, 10476.63331783384, 10519.26365154432, 10553.366797992145, 10647.094996925192, 10397.896021039693, 10489.947550262352, 10510.947445262726, 10541.0, 10556.208284378703, 7923.484973476706, 8262.215089566482, 8332.291755200877, 8335.749927502186, 8350.997880254408, 7771.222877712184, 7827.4129440293345, 7851.1363749988595, 7861.52830830152, 7865.842683146419, 9212.401193922373, 9582.904170958202, 9583.712488625353, 9597.0, 9702.466364350028, 9530.0, 9732.97803730598, 9889.703308900744, 9956.651517196864, 9996.450195239331, 7444.925550744423, 7509.249075092447, 7517.398608111447, 7522.022137122139, 7529.962350188214, 7391.445641577011, 7563.886541701989, 7795.41534384912, 8078.555679437687, 8107.14874938123, 6825.863482730417, 7093.716251350094, 7490.026296581627, 7639.770806875803, 7782.338501227459, 7305.379042781423, 7339.192688804121, 7534.8493030138, 7563.697452102075, 7579.431542634215, 7372.262773722585, 7601.885971710318, 7708.537487750753, 7746.92253077462, 7748.0, 5830.271216097988, 6968.163820341591, 6983.615901125487, 6991.545549539263, 6997.9503074539225, 6809.557378770364, 7078.044463997295, 7109.040279562193, 7121.786346409616, 7135.215126336203], "unit": "score", "name": "mootools.html", "value": 4913.333074632316}, {"lowerIsBetter": false, "replicates": [321.8953840001999, 327.18204488778053, 332.2623775219014, 335.3243214921931, 341.4656063260998, 6500.902486462695, 6584.045313429556, 6652.866942661144, 6695.0, 6707.631080290582, 6419.229692436902, 6422.743090276384, 6601.900971485419, 6602.537822352438, 6604.438622717074, 4882.4141103067595, 4882.731449770261, 4885.36490256268, 4887.633427492934, 4890.437599676029, 4640.512746161655, 4735.408073990751, 4791.760411979404, 4818.662693611449, 4891.364122664048, 4771.618270538349, 4787.569118779309, 4802.471728109905, 4803.831865884695, 4805.927911081337, 4801.039792041588, 4863.8297659582095, 4873.098476781806, 4874.707517548958, 4880.023995200974, 4160.83356665733, 4168.103857670615, 4168.937465938014, 4172.457580514544, 4177.10192308652, 6090.5736598438125, 6320.74717011319, 6325.841853953642, 6345.143405640226, 6353.205849268841, 5581.246531718207, 5622.971885140548, 5626.268585083953, 5627.943720562783, 5640.633358831663, 5870.383609721003, 6371.39471750183, 6653.567518111307, 6948.409385202264, 7026.508144429892, 3961.207758448293, 4514.932276015862, 4538.228501154812, 4559.316102584606, 4564.42944631921, 5964.224650795369, 7265.346118849276, 7396.778096657002, 7405.8889116663295, 7420.4805663603565, 4605.930911036337, 4611.100835337077, 4612.584867361954, 4613.284940834176, 4623.768811559408, 4542.227821270392, 4719.480857105716, 4724.126036683225, 4731.834385796481, 4735.668503204743, 4562.292844609091, 4677.345171675968, 5544.7227638618715, 5612.214289999403, 5619.550435965113, 7100.68046937889, 7103.680334384965, 7106.7157313706875, 7106.893396599055, 7125.3230943060325, 1578.0373971877145, 1615.4991952494763, 1637.6479057002803, 1639.6146905477203, 1645.4323258475806, 1022.25375475903, 1034.5086084109987, 1042.635077722791, 1046.4349251404155, 1048.2138396202847, 6339.904901426482, 6441.0, 6453.903191452132, 6458.935410645833, 6486.837829054311, 7252.456065795086, 7259.548090381839, 7259.89110163348, 7259.9274007259255, 7265.7820265391065, 6353.633968696752, 6447.4197322241225, 6454.128692626436, 6454.677266136674, 6456.709448074848, 3858.5562660293863, 3890.8638197662945, 3915.7258991870294, 3917.2361389529337, 3918.2359439908946, 7751.844963100706, 7753.263439973193, 7757.650905709256, 7759.612019399007, 7762.68949242024, 7418.221086785809, 7601.011868457065, 7636.045494313211, 7672.117706463717, 7674.040744906887, 6262.0, 6982.825429364409, 7675.347595454449, 7685.346745526581, 7699.191584883619, 7090.858182836418, 7176.677049532679, 7286.344229019413, 7312.268773122645, 7373.741919032808, 7226.530275532074, 7240.565566066053, 7251.456140789567, 7259.854802903807, 7263.455240856852, 7383.261673832574, 7622.31399174077, 7722.38220942312, 7727.304542591194, 7728.381729461742, 4753.595944344769, 4811.879703007453, 4812.5187481253, 4827.227643577011, 4828.95171048285, 7161.391281740902, 7182.928170718226, 7184.425245980205, 7231.204567497676, 7262.527935684375, 5918.757061017062, 6051.0923361496125, 6774.848275793225, 7023.33278338557, 7036.9296307036275, 6514.609123452608, 7049.365557099681, 7056.0, 7058.894116588358, 7072.434205263669, 5503.532199763065, 6818.147731533559, 6827.48793840454, 6828.419584335387, 6840.247572767091, 6729.966350168218, 6980.546264492792, 7001.649917504206, 7007.474439417166, 7019.894701579378, 6868.141482314711, 6892.310768923067, 6901.896471553031, 6903.447724182154, 6906.240313565403], "unit": "score", "name": "prototype.html", "value": 5111.1012241373355}, {"lowerIsBetter": false, "replicates": [726.5313872552204, 732.1763016606318, 737.660676088999, 747.3647399710247, 778.9961050194748, 17170.14149292535, 17486.30054797808, 17488.475345739615, 17495.037772922486, 17542.473725788248, 15533.456329028486, 15571.766423503657, 15593.610159745984, 15605.609859753511, 15623.84376156238, 689.4381079420282, 705.6894966214875, 789.8744289387629, 858.2318824651933, 870.7387783664907, 607.3622696169027, 672.4835495956611, 696.5228818259483, 698.1029377250235, 698.552926127279, 895.2166854002747, 903.0833703790657, 911.1480765484293, 911.4075850697034, 912.8813254276935, 900.9774755631096, 901.1664210605164, 903.8327909336793, 904.8235594059161, 905.3119629081945, 537.965032272901, 546.8168163665177, 660.5475249454139, 665.9733610655568, 670.2225418514499, 14743.410263589443, 15098.0, 15102.471413500474, 15146.621334466616, 15160.545183644508, 9998.0, 12153.392330383534, 12201.511939522408, 12467.0, 12660.303683297416, 10053.447060411674, 10143.442110683909, 10234.846477302846, 10329.380237185793, 10867.619633312876, 3467.2545402738533, 3508.456189290664, 3509.280597477511, 3510.8420121094614, 3517.103138699615, 65696.67151664259, 65940.67029664869, 84526.15473845306, 85826.0, 86075.13924860797, 7491.400687944952, 9256.352055356061, 9459.0, 9607.279454040974, 9864.062914023156, 17372.13139343053, 20152.29466968649, 20630.968451577362, 20639.793602063786, 20658.79341206599, 7126.964365178141, 7233.0, 7274.745383911538, 7353.338199562065, 7374.188839227681, 4071.572484889103, 4123.0, 4124.793760311973, 4133.090720041586, 4144.109016561393, 2860.485112679696, 3437.553118094632, 3444.0873168610337, 3447.379471695119, 3459.515667806509, 608.6500262349167, 620.9937900621027, 627.4165026525375, 638.0270088115568, 645.0034696394082, 541.6966498760706, 602.6835911146683, 609.0, 625.7809766581751, 626.3360837512251, 8388.8741668875, 8505.829883402297, 8508.361872859436, 8611.741647750578, 8721.389502734748, 501.4033300372545, 525.2751203339367, 600.945914867664, 609.6524980760923, 620.7734177025353, 3057.29682173097, 3897.922041559153, 4341.565843415633, 4372.956270437255, 4381.978090109529, 92000.0, 92880.0, 93641.0, 93876.12247755006, 100581.0, 83740.58129709313, 84113.0, 84822.0, 84942.0, 85473.14526854652, 65528.378864844875, 65759.67120164368, 66072.66963665151, 66824.33175668182, 69419.65290173618, 8888.0, 9027.368084234304, 9034.45793252407, 9034.683786067457, 9208.12522810332, 32963.835180823946, 37036.44445333268, 47736.761316193195, 48326.75836620794, 49826.501734983634, 58421.415785843295, 64261.39346516375, 64441.67779161074, 65449.67275163594, 70520.0, 10928.235023548275, 11152.357082708131, 11269.774604508028, 11388.544458221579, 11516.884831151581, 11696.034475036908, 11934.85562113709, 11968.028295653996, 12758.6172414824, 12923.806142907675, 11548.307101573933, 11589.304641721523, 11954.58158964432, 11962.0, 11965.581204658143, 11196.272242304223, 11383.089352851917, 11754.529818807152, 11787.587434439753, 12195.939020304842, 9418.62325506972, 11283.492242849255, 11642.24325418845, 11658.53365865356, 12077.51689932393, 9259.398139120936, 9266.814663706822, 9342.813143737223, 9568.665096721581, 9606.471644059364, 9193.0, 9223.192299082051, 9553.522323883917, 9797.657082002095, 9803.754906127404], "unit": "score", "name": "yui.html", "value": 6801.751974033066}], "name": "dromaeo_css", "value": 7362.8097007815895}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 107.0, 111.0, 112.0, 118.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [158.0, 124.0, 142.0, 156.0, 120.0, 150.0, 161.0, 146.0, 160.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 143.7}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 188.0, 187.0, 186.0, 185.0, 184.0, 183.0, 181.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.6}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 87.0, 77.0, 57.0, 58.0, 61.0, 87.0, 100.0, 68.0], "unit": "score", "name": "audio-fft", "value": 74.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 124.0, 78.0, 80.0, 83.0, 110.0, 76.0, 78.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 92.9}, {"lowerIsBetter": true, "replicates": [87.0, 89.0, 84.0, 91.0, 85.0, 91.0, 92.0, 91.0, 85.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.9}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 87.0, 86.0, 87.0, 85.0, 86.0, 84.0, 87.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 85.9}, {"lowerIsBetter": true, "replicates": [55.0, 52.0, 51.0, 49.0, 52.0, 55.0, 53.0, 64.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 53.8}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 67.0, 77.0, 67.0, 70.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 84.0, 95.0, 109.0, 106.0, 106.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.7}, {"lowerIsBetter": true, "replicates": [125.0, 125.0, 129.0, 127.0, 122.0, 132.0, 126.0, 126.0, 123.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [126.0, 129.0, 138.0, 137.0, 139.0, 127.0, 139.0, 137.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.6}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1414.8999999999999}]} 00:03:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1414.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7362.81"}}} 00:03:15 INFO - Return code: 0 00:03:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:03:15 INFO - # TBPL SUCCESS # 00:03:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:03:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:03:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:03:15 INFO - 2016-02-11 00:03:15.873 screenresolution[1971:13549] starting screenresolution argv=screenresolution get 00:03:15 INFO - 2016-02-11 00:03:15.875 screenresolution[1971:13549] Display 0: 1600x1200x32@60 00:03:15 INFO - 2016-02-11 00:03:15.881 screenresolution[1972:13552] starting screenresolution argv=screenresolution list 00:03:15 INFO - Available Modes on Display 0 00:03:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:03:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:03:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:03:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:03:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:03:16 INFO - Intel Iris: 00:03:16 INFO - Chipset Model: Intel Iris 00:03:16 INFO - Type: GPU 00:03:16 INFO - Bus: Built-In 00:03:16 INFO - VRAM (Dynamic, Max): 1536 MB 00:03:16 INFO - Vendor: Intel (0x8086) 00:03:16 INFO - Device ID: 0x0a2e 00:03:16 INFO - Revision ID: 0x0009 00:03:16 INFO - Displays: 00:03:16 INFO - Display: 00:03:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:03:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:03:16 INFO - Display Serial Number: 1600x1200 60 00:03:16 INFO - Main Display: Yes 00:03:16 INFO - Mirror: Off 00:03:16 INFO - Online: Yes 00:03:16 INFO - Rotation: Supported 00:03:16 INFO - Return code: 0 00:03:16 INFO - Running post-action listener: _resource_record_post_action 00:03:16 INFO - Running post-run listener: _resource_record_post_run 00:03:17 INFO - Total resource usage - Wall time: 1208s; CPU: 52.0%; Read bytes: 4091904; Write bytes: 713678848; Read time: 101; Write time: 2243 00:03:17 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401156608; Write bytes: 396480512; Read time: 30228; Write time: 732 00:03:17 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 3231744; Write bytes: 305684480; Read time: 95; Write time: 1480 00:03:17 INFO - Running post-run listener: _upload_blobber_files 00:03:17 INFO - Blob upload gear active. 00:03:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:03:17 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 00:03:17 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'] 00:03:17 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 00:03:17 INFO - (blobuploader) - INFO - Open directory for files ... 00:03:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:03:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:03:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:18 INFO - (blobuploader) - INFO - Done attempting. 00:03:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:03:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:03:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:19 INFO - (blobuploader) - INFO - Done attempting. 00:03:19 INFO - (blobuploader) - INFO - Iteration through files over. 00:03:19 INFO - Return code: 0 00:03:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:03:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:03:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06eb2b4f5d5a636b9e157b45632671da3c0f6ccd491ec364aff245b9dc700d462c3a98e7bd5ab228db12bd35313fa8b6e638d264ae21a99ce69563d3903493b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0db1e03d24b6a250de8aca51437ae974aff770eb38f3968c852e24f79a0ce2a3e383f53d1b83b77830ee8e309e7a1a75d443961982007f61c978ff0800363868"} 00:03:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:03:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:03:19 INFO - Contents: 00:03:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06eb2b4f5d5a636b9e157b45632671da3c0f6ccd491ec364aff245b9dc700d462c3a98e7bd5ab228db12bd35313fa8b6e638d264ae21a99ce69563d3903493b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0db1e03d24b6a250de8aca51437ae974aff770eb38f3968c852e24f79a0ce2a3e383f53d1b83b77830ee8e309e7a1a75d443961982007f61c978ff0800363868"} 00:03:19 INFO - Running post-run listener: copy_logs_to_upload_dir 00:03:19 INFO - Copying logs to upload dir... 00:03:19 INFO - mkdir: /builds/slave/test/build/upload/logs 00:03:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.062639 ========= master_lag: 38.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2016-02-11 00:03:57.565548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 20 secs) (at 2016-02-11 00:03:57.568880) ========= 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.hG2r4mfW1l/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.0mQbw35P8O/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06eb2b4f5d5a636b9e157b45632671da3c0f6ccd491ec364aff245b9dc700d462c3a98e7bd5ab228db12bd35313fa8b6e638d264ae21a99ce69563d3903493b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0db1e03d24b6a250de8aca51437ae974aff770eb38f3968c852e24f79a0ce2a3e383f53d1b83b77830ee8e309e7a1a75d443961982007f61c978ff0800363868"} build_url:https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011751 build_url: 'https://queue.taskcluster.net/v1/task/Zuf0HHvMSfi2CwhOJ9bHcg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06eb2b4f5d5a636b9e157b45632671da3c0f6ccd491ec364aff245b9dc700d462c3a98e7bd5ab228db12bd35313fa8b6e638d264ae21a99ce69563d3903493b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0db1e03d24b6a250de8aca51437ae974aff770eb38f3968c852e24f79a0ce2a3e383f53d1b83b77830ee8e309e7a1a75d443961982007f61c978ff0800363868"}' ========= master_lag: 20.21 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 20 secs) (at 2016-02-11 00:04:17.794379) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 00:04:17.794864) ========= 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.hG2r4mfW1l/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.0mQbw35P8O/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.005664 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 00:04:17.829855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 00:04:17.830353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 00:04:17.837208) ========= ========= Total master_lag: 58.62 =========