builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0186 starttime: 1456251132.07 results: success (0) buildid: 20160223080008 builduid: 2dbdab544e6a47e3bd2a96aa2fe27131 revision: 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:12.070037) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:12.070440) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:12.070758) ========= 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.CIc27o8R65/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.IelLpnwqDY/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.005628 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:12.098168) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:12.098463) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:12.122209) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-02-23 10:12:12.122498) ========= 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.CIc27o8R65/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.IelLpnwqDY/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.005256 ========= master_lag: 2.97 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-02-23 10:12:15.097988) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:15.102309) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:15.102661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:15.102952) ========= 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.CIc27o8R65/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.IelLpnwqDY/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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-23 10:12:15-- 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% 21.5M=0.001s 2016-02-23 10:12:15 (21.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182819 ========= master_lag: 0.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:15.571399) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:15.571747) ========= 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.CIc27o8R65/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.IelLpnwqDY/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.019256 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:15.610523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 10:12:15.610894) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 --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 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CIc27o8R65/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.IelLpnwqDY/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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-23 10:12:15,678 truncating revision to first 12 chars 2016-02-23 10:12:15,678 Setting DEBUG logging. 2016-02-23 10:12:15,678 attempt 1/10 2016-02-23 10:12:15,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4d32d1f87b74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 10:12:16,438 unpacking tar archive at: fx-team-4d32d1f87b74/testing/mozharness/ program finished with exit code 0 elapsedTime=0.994807 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 10:12:16.624695) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:16.625061) ========= echo 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CIc27o8R65/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.IelLpnwqDY/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 program finished with exit code 0 elapsedTime=0.005155 script_repo_revision: '4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:16.674665) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:16.675000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:16.688636) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 36 secs) (at 2016-02-23 10:12:16.689030) ========= /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.CIc27o8R65/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.IelLpnwqDY/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 10:12:16 INFO - MultiFileLogger online at 20160223 10:12:16 in /builds/slave/test 10:12:16 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 10:12:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:12:16 INFO - {'append_to_log': False, 10:12:16 INFO - 'base_work_dir': '/builds/slave/test', 10:12:16 INFO - 'blob_upload_branch': 'Fx-Team', 10:12:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:12:16 INFO - 'branch': 'Fx-Team', 10:12:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:12:16 INFO - 'config_files': ('talos/mac_config.py',), 10:12:16 INFO - 'default_actions': ('clobber', 10:12:16 INFO - 'read-buildbot-config', 10:12:16 INFO - 'download-and-extract', 10:12:16 INFO - 'populate-webroot', 10:12:16 INFO - 'create-virtualenv', 10:12:16 INFO - 'install', 10:12:16 INFO - 'run-tests'), 10:12:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:12:16 INFO - 'download_minidump_stackwalk': True, 10:12:16 INFO - 'download_symbols': 'ondemand', 10:12:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:12:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:12:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:12:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:12:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:12:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:12:16 INFO - 'installer_path': 'installer.exe', 10:12:16 INFO - 'log_level': 'info', 10:12:16 INFO - 'log_name': 'talos', 10:12:16 INFO - 'log_to_console': True, 10:12:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:12:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:12:16 INFO - 'opt_config_files': (), 10:12:16 INFO - 'pip_index': False, 10:12:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:12:16 INFO - 'cmd': ('bash', 10:12:16 INFO - '-c', 10:12:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:12:16 INFO - 'enabled': True, 10:12:16 INFO - 'halt_on_failure': False, 10:12:16 INFO - 'name': 'check_screen_resolution'},), 10:12:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:12:16 INFO - 'cmd': ('bash', 10:12:16 INFO - '-c', 10:12:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:12:16 INFO - 'enabled': True, 10:12:16 INFO - 'halt_on_failure': False, 10:12:16 INFO - 'name': 'check_screen_resolution'},), 10:12:16 INFO - 'run_cmd_checks_enabled': True, 10:12:16 INFO - 'sps_profile': False, 10:12:16 INFO - 'sps_profile_interval': 0, 10:12:16 INFO - 'suite': 'dromaeojs', 10:12:16 INFO - 'system_bits': '32', 10:12:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:12:16 INFO - 'title': 't-yosemite-r7-0186', 10:12:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:12:16 INFO - 'use_talos_json': True, 10:12:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:12:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:12:16 INFO - 'work_dir': 'build'} 10:12:16 INFO - ##### 10:12:16 INFO - ##### Running clobber step. 10:12:16 INFO - ##### 10:12:16 INFO - Running pre-action listener: _resource_record_pre_action 10:12:16 INFO - Running main action method: clobber 10:12:16 INFO - rmtree: /builds/slave/test/build 10:12:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:12:18 INFO - Running post-action listener: _resource_record_post_action 10:12:18 INFO - ##### 10:12:18 INFO - ##### Running read-buildbot-config step. 10:12:18 INFO - ##### 10:12:18 INFO - Running pre-action listener: _resource_record_pre_action 10:12:18 INFO - Running main action method: read_buildbot_config 10:12:18 INFO - Using buildbot properties: 10:12:18 INFO - { 10:12:18 INFO - "project": "", 10:12:18 INFO - "product": "firefox", 10:12:18 INFO - "script_repo_revision": "production", 10:12:18 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:12:18 INFO - "repository": "", 10:12:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:12:18 INFO - "buildid": "20160223080008", 10:12:18 INFO - "pgo_build": "False", 10:12:18 INFO - "basedir": "/builds/slave/test", 10:12:18 INFO - "buildnumber": 413, 10:12:18 INFO - "slavename": "t-yosemite-r7-0186", 10:12:18 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:12:18 INFO - "platform": "yosemite_r7", 10:12:18 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:12:18 INFO - "branch": "fx-team", 10:12:18 INFO - "repo_path": "integration/fx-team", 10:12:18 INFO - "revision": "4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099", 10:12:18 INFO - "stage_platform": "macosx64", 10:12:18 INFO - "builduid": "2dbdab544e6a47e3bd2a96aa2fe27131", 10:12:18 INFO - "slavebuilddir": "test" 10:12:18 INFO - } 10:12:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 10:12:18 INFO - Running post-action listener: _resource_record_post_action 10:12:18 INFO - ##### 10:12:18 INFO - ##### Running download-and-extract step. 10:12:18 INFO - ##### 10:12:18 INFO - Running pre-action listener: _resource_record_pre_action 10:12:18 INFO - Running main action method: download_and_extract 10:12:18 INFO - mkdir: /builds/slave/test/build/tests 10:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:18 INFO - https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:12:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/test_packages.json 10:12:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/test_packages.json 10:12:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:12:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:12:19 INFO - Downloaded 1277 bytes. 10:12:19 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:12:19 INFO - Using the following test package requirements: 10:12:19 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:12:19 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:19 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 10:12:19 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:19 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 10:12:19 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:19 INFO - u'jsshell-mac.zip'], 10:12:19 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:19 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 10:12:19 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:12:19 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:19 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 10:12:19 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:19 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 10:12:19 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:19 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 10:12:19 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:12:19 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:19 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 10:12:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:12: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')]} 10:12:19 INFO - https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:12:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:12:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:12:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/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 10:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/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 10:12:20 INFO - Downloaded 17825734 bytes. 10:12:20 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'] 10:12:20 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 10:12:23 INFO - Return code: 0 10:12:23 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 10:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:23 INFO - https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:12:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:12:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:12:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/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 10:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/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 10:12:24 INFO - Downloaded 17825734 bytes. 10:12:24 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'] 10:12:24 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 10:12:27 INFO - Return code: 0 10:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:27 INFO - https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:12:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:12:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:12:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/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 10:12:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/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 10:12:28 INFO - Downloaded 10707015 bytes. 10:12:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:12:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:12:28 INFO - Return code: 0 10:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:28 INFO - https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:12:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:12:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:12:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 10:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/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 10:12:31 INFO - Downloaded 111443570 bytes. 10:12:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:12:31 INFO - mkdir: /builds/slave/test/properties 10:12:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:31 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:31 INFO - Contents: 10:12:31 INFO - build_url:https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:12:32 INFO - Running post-action listener: _resource_record_post_action 10:12:32 INFO - Running post-action listener: set_extra_try_arguments 10:12:32 INFO - ##### 10:12:32 INFO - ##### Running populate-webroot step. 10:12:32 INFO - ##### 10:12:32 INFO - Running pre-action listener: _resource_record_pre_action 10:12:32 INFO - Running main action method: populate_webroot 10:12:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:32 INFO - '--tppagecycles', 10:12:32 INFO - '7'], 10:12:32 INFO - 'tests': ['tsvgm']}}, 10:12:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:12:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:12:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:12:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:12:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:32 INFO - 'talos_options': ['--e10s'], 10:12:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:32 INFO - 'tests': ['damp', 'tps']}, 10:12:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:32 INFO - 'talos_options': ['--e10s'], 10:12:32 INFO - 'tests': ['damp', 'tps']}, 10:12:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:12:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:32 INFO - 'other': {'tests': ['a11yr', 10:12:32 INFO - 'ts_paint', 10:12:32 INFO - 'tpaint', 10:12:32 INFO - 'sessionrestore', 10:12:32 INFO - 'sessionrestore_no_auto_restore']}, 10:12:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:12:32 INFO - 'tests': ['a11yr', 10:12:32 INFO - 'ts_paint', 10:12:32 INFO - 'tpaint', 10:12:32 INFO - 'sessionrestore', 10:12:32 INFO - 'sessionrestore_no_auto_restore']}, 10:12:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:12:32 INFO - 'tests': ['a11yr', 10:12:32 INFO - 'ts_paint', 10:12:32 INFO - 'tpaint', 10:12:32 INFO - 'sessionrestore', 10:12:32 INFO - 'sessionrestore_no_auto_restore']}, 10:12:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:12:32 INFO - 'tests': ['a11yr', 10:12:32 INFO - 'ts_paint', 10:12:32 INFO - 'tpaint', 10:12:32 INFO - 'sessionrestore', 10:12:32 INFO - 'sessionrestore_no_auto_restore']}, 10:12:32 INFO - 'other_l64': {'tests': ['a11yr', 10:12:32 INFO - 'ts_paint', 10:12:32 INFO - 'tpaint', 10:12:32 INFO - 'sessionrestore', 10:12:32 INFO - 'sessionrestore_no_auto_restore']}, 10:12:32 INFO - 'other_nol64': {'tests': ['a11yr', 10:12:32 INFO - 'ts_paint', 10:12:32 INFO - 'tpaint', 10:12:32 INFO - 'sessionrestore', 10:12:32 INFO - 'sessionrestore_no_auto_restore']}, 10:12:32 INFO - 'svgr': {'tests': ['tsvgx', 10:12:32 INFO - 'tsvgr_opacity', 10:12:32 INFO - 'tart', 10:12:32 INFO - 'tscrollx', 10:12:32 INFO - 'cart']}, 10:12:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:12:32 INFO - 'tests': ['tsvgx', 10:12:32 INFO - 'tsvgr_opacity', 10:12:32 INFO - 'tart', 10:12:32 INFO - 'tscrollx', 10:12:32 INFO - 'cart']}, 10:12:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:32 INFO - 'tests': ['tp5o']}, 10:12:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:32 INFO - 'talos_options': ['--e10s'], 10:12:32 INFO - 'tests': ['tp5o']}, 10:12:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:32 INFO - 'talos_options': ['--xperf_path', 10:12:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:32 INFO - 'tests': ['tp5n']}, 10:12:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:32 INFO - 'talos_options': ['--e10s', 10:12:32 INFO - '--xperf_path', 10:12:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:32 INFO - 'tests': ['tp5n']}}, 10:12:32 INFO - 'talos.zip': {'path': '', 10:12:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:32 INFO - Running post-action listener: _resource_record_post_action 10:12:32 INFO - ##### 10:12:32 INFO - ##### Running create-virtualenv step. 10:12:32 INFO - ##### 10:12:32 INFO - Running pre-action listener: _resource_record_pre_action 10:12:32 INFO - Running main action method: create_virtualenv 10:12:32 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:12:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:32 INFO - Using real prefix '/tools/python27' 10:12:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:33 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:36 INFO - Installing pip.................done. 10:12:36 INFO - Return code: 0 10:12:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d2ccddb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b03d30>, '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 0x108927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108afab20>, '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.CIc27o8R65/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.IelLpnwqDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 10:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:12:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CIc27o8R65/Render', 10:12:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:36 INFO - 'HOME': '/Users/cltbld', 10:12:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:36 INFO - 'LOGNAME': 'cltbld', 10:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:36 INFO - 'MOZ_NO_REMOTE': '1', 10:12:36 INFO - 'NO_EM_RESTART': '1', 10:12:36 INFO - 'PAGER': '/bin/cat', 10:12:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:36 INFO - 'PWD': '/builds/slave/test', 10:12:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:36 INFO - 'SHELL': '/bin/bash', 10:12:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IelLpnwqDY/Listeners', 10:12:36 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 10:12:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:36 INFO - 'USER': 'cltbld', 10:12:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:36 INFO - 'XPC_FLAGS': '0x0', 10:12:36 INFO - 'XPC_SERVICE_NAME': '0', 10:12:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:12:36 INFO - Cleaning up... 10:12:36 INFO - Return code: 0 10:12:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d2ccddb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b03d30>, '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 0x108927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108afab20>, '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.CIc27o8R65/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.IelLpnwqDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 10:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:12:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CIc27o8R65/Render', 10:12:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:36 INFO - 'HOME': '/Users/cltbld', 10:12:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:36 INFO - 'LOGNAME': 'cltbld', 10:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:36 INFO - 'MOZ_NO_REMOTE': '1', 10:12:36 INFO - 'NO_EM_RESTART': '1', 10:12:36 INFO - 'PAGER': '/bin/cat', 10:12:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:36 INFO - 'PWD': '/builds/slave/test', 10:12:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:36 INFO - 'SHELL': '/bin/bash', 10:12:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IelLpnwqDY/Listeners', 10:12:36 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 10:12:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:36 INFO - 'USER': 'cltbld', 10:12:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:36 INFO - 'XPC_FLAGS': '0x0', 10:12:36 INFO - 'XPC_SERVICE_NAME': '0', 10:12:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:36 INFO - Downloading/unpacking psutil>=0.7.1 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:39 INFO - Installing collected packages: psutil 10:12:39 INFO - Running setup.py install for psutil 10:12:40 INFO - building 'psutil._psutil_osx' extension 10:12:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:12:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:12:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:12:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:12:40 INFO - building 'psutil._psutil_posix' extension 10:12:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:12:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:12:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:12:40 INFO - ^ 10:12:40 INFO - 1 warning generated. 10:12:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:12:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:40 INFO - Successfully installed psutil 10:12:40 INFO - Cleaning up... 10:12:40 INFO - Return code: 0 10:12:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d2ccddb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b03d30>, '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 0x108927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108afab20>, '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.CIc27o8R65/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.IelLpnwqDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 10:12:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CIc27o8R65/Render', 10:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:40 INFO - 'HOME': '/Users/cltbld', 10:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:40 INFO - 'LOGNAME': 'cltbld', 10:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:40 INFO - 'MOZ_NO_REMOTE': '1', 10:12:40 INFO - 'NO_EM_RESTART': '1', 10:12:40 INFO - 'PAGER': '/bin/cat', 10:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:40 INFO - 'PWD': '/builds/slave/test', 10:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:40 INFO - 'SHELL': '/bin/bash', 10:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IelLpnwqDY/Listeners', 10:12:40 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 10:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:40 INFO - 'USER': 'cltbld', 10:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:40 INFO - 'XPC_FLAGS': '0x0', 10:12:40 INFO - 'XPC_SERVICE_NAME': '0', 10:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:12:43 INFO - Installing collected packages: mozsystemmonitor 10:12:43 INFO - Running setup.py install for mozsystemmonitor 10:12:43 INFO - Successfully installed mozsystemmonitor 10:12:43 INFO - Cleaning up... 10:12:43 INFO - Return code: 0 10:12:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d2ccddb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b03d30>, '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 0x108927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108afab20>, '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.CIc27o8R65/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.IelLpnwqDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 10:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:12:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CIc27o8R65/Render', 10:12:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:43 INFO - 'HOME': '/Users/cltbld', 10:12:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:43 INFO - 'LOGNAME': 'cltbld', 10:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:43 INFO - 'MOZ_NO_REMOTE': '1', 10:12:43 INFO - 'NO_EM_RESTART': '1', 10:12:43 INFO - 'PAGER': '/bin/cat', 10:12:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:43 INFO - 'PWD': '/builds/slave/test', 10:12:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:43 INFO - 'SHELL': '/bin/bash', 10:12:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IelLpnwqDY/Listeners', 10:12:43 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 10:12:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:43 INFO - 'USER': 'cltbld', 10:12:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:43 INFO - 'XPC_FLAGS': '0x0', 10:12:43 INFO - 'XPC_SERVICE_NAME': '0', 10:12:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:43 INFO - Downloading/unpacking blobuploader==1.2.4 10:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:46 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:47 INFO - Downloading docopt-0.6.1.tar.gz 10:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:47 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:47 INFO - Running setup.py install for blobuploader 10:12:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:47 INFO - Running setup.py install for requests 10:12:48 INFO - Running setup.py install for docopt 10:12:48 INFO - Successfully installed blobuploader requests docopt 10:12:48 INFO - Cleaning up... 10:12:48 INFO - Return code: 0 10:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d2ccddb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b03d30>, '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 0x108927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108afab20>, '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.CIc27o8R65/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.IelLpnwqDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 10:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:12:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CIc27o8R65/Render', 10:12:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:48 INFO - 'HOME': '/Users/cltbld', 10:12:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:48 INFO - 'LOGNAME': 'cltbld', 10:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:48 INFO - 'MOZ_NO_REMOTE': '1', 10:12:48 INFO - 'NO_EM_RESTART': '1', 10:12:48 INFO - 'PAGER': '/bin/cat', 10:12:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:48 INFO - 'PWD': '/builds/slave/test', 10:12:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:48 INFO - 'SHELL': '/bin/bash', 10:12:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IelLpnwqDY/Listeners', 10:12:48 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 10:12:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:48 INFO - 'USER': 'cltbld', 10:12:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:48 INFO - 'XPC_FLAGS': '0x0', 10:12:48 INFO - 'XPC_SERVICE_NAME': '0', 10:12:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:48 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-UTMfeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:48 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-aZXQtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:48 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-EEaY7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:48 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Tdi8Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:49 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-KTFpcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:49 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-KeQTHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:49 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-lU3GcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:49 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-470WkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:49 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-GGpbAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:49 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Vmsa1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:49 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-pD1OuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:49 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Or0820-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:49 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-KdxgVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:49 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-i8SHc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:50 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-yHHmjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:50 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-zsuQkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:50 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-sjqJyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:12:50 INFO - Running setup.py install for manifestparser 10:12:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:12:50 INFO - Running setup.py install for mozcrash 10:12:50 INFO - Running setup.py install for mozdebug 10:12:50 INFO - Running setup.py install for mozdevice 10:12:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:12:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:50 INFO - Running setup.py install for mozfile 10:12:51 INFO - Running setup.py install for mozhttpd 10:12:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:51 INFO - Running setup.py install for mozinfo 10:12:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:51 INFO - Running setup.py install for mozInstall 10:12:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:51 INFO - Running setup.py install for mozleak 10:12:51 INFO - Running setup.py install for mozlog 10:12:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:51 INFO - Running setup.py install for moznetwork 10:12:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:52 INFO - Running setup.py install for mozprocess 10:12:52 INFO - Running setup.py install for mozprofile 10:12:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:52 INFO - Running setup.py install for mozrunner 10:12:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:52 INFO - Running setup.py install for mozscreenshot 10:12:52 INFO - Running setup.py install for moztest 10:12:52 INFO - Running setup.py install for mozversion 10:12:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:52 INFO - Cleaning up... 10:12:52 INFO - Return code: 0 10:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d2ccddb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b03d30>, '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 0x108927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108afab20>, '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.CIc27o8R65/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.IelLpnwqDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 10:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:12:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CIc27o8R65/Render', 10:12:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:52 INFO - 'HOME': '/Users/cltbld', 10:12:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:52 INFO - 'LOGNAME': 'cltbld', 10:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:52 INFO - 'MOZ_NO_REMOTE': '1', 10:12:52 INFO - 'NO_EM_RESTART': '1', 10:12:52 INFO - 'PAGER': '/bin/cat', 10:12:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:52 INFO - 'PWD': '/builds/slave/test', 10:12:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:52 INFO - 'SHELL': '/bin/bash', 10:12:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IelLpnwqDY/Listeners', 10:12:52 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 10:12:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:52 INFO - 'USER': 'cltbld', 10:12:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:52 INFO - 'XPC_FLAGS': '0x0', 10:12:52 INFO - 'XPC_SERVICE_NAME': '0', 10:12:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:53 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-vwkdZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:53 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-M3Whr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:53 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-TZ7eDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:53 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-I8qRHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:53 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-FdQTvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:53 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-W9EZ19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:53 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-hZgzdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:53 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-mHuQHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:54 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-zChsxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:54 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-1PRJ1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:54 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-qtloBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:54 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-v8BzeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:54 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-RofizG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:54 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-zFlrMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:54 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-ohXz4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:54 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-4mrUr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:54 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Sa4h_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:12:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:57 INFO - Downloading blessings-1.6.tar.gz 10:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:57 INFO - Installing collected packages: blessings 10:12:57 INFO - Running setup.py install for blessings 10:12:57 INFO - Successfully installed blessings 10:12:57 INFO - Cleaning up... 10:12:57 INFO - Return code: 0 10:12:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:57 INFO - Reading from file tmpfile_stdout 10:12:57 INFO - Current package versions: 10:12:57 INFO - blessings == 1.6 10:12:57 INFO - blobuploader == 1.2.4 10:12:57 INFO - docopt == 0.6.1 10:12:57 INFO - manifestparser == 1.1 10:12:57 INFO - mozInstall == 1.12 10:12:57 INFO - mozcrash == 0.16 10:12:57 INFO - mozdebug == 0.1 10:12:57 INFO - mozdevice == 0.48 10:12:57 INFO - mozfile == 1.2 10:12:57 INFO - mozhttpd == 0.7 10:12:57 INFO - mozinfo == 0.9 10:12:57 INFO - mozleak == 0.1 10:12:57 INFO - mozlog == 3.1 10:12:57 INFO - moznetwork == 0.27 10:12:57 INFO - mozprocess == 0.22 10:12:57 INFO - mozprofile == 0.28 10:12:57 INFO - mozrunner == 6.11 10:12:57 INFO - mozscreenshot == 0.1 10:12:57 INFO - mozsystemmonitor == 0.0 10:12:57 INFO - moztest == 0.7 10:12:57 INFO - mozversion == 1.4 10:12:57 INFO - psutil == 3.1.1 10:12:57 INFO - requests == 1.2.3 10:12:57 INFO - wsgiref == 0.1.2 10:12:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d2ccddb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b03d30>, '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 0x108927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108afab20>, '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.CIc27o8R65/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.IelLpnwqDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 10:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:12:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CIc27o8R65/Render', 10:12:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:57 INFO - 'HOME': '/Users/cltbld', 10:12:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:57 INFO - 'LOGNAME': 'cltbld', 10:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:57 INFO - 'MOZ_NO_REMOTE': '1', 10:12:57 INFO - 'NO_EM_RESTART': '1', 10:12:57 INFO - 'PAGER': '/bin/cat', 10:12:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:57 INFO - 'PWD': '/builds/slave/test', 10:12:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:57 INFO - 'SHELL': '/bin/bash', 10:12:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IelLpnwqDY/Listeners', 10:12:57 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 10:12:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:57 INFO - 'USER': 'cltbld', 10:12:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:57 INFO - 'XPC_FLAGS': '0x0', 10:12:57 INFO - 'XPC_SERVICE_NAME': '0', 10:12:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:12:58 INFO - Cleaning up... 10:12:58 INFO - Return code: 0 10:12:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d2ccddb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b03d30>, '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 0x108927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108afab20>, '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.CIc27o8R65/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.IelLpnwqDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 10:12:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CIc27o8R65/Render', 10:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:58 INFO - 'HOME': '/Users/cltbld', 10:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:58 INFO - 'LOGNAME': 'cltbld', 10:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:58 INFO - 'MOZ_NO_REMOTE': '1', 10:12:58 INFO - 'NO_EM_RESTART': '1', 10:12:58 INFO - 'PAGER': '/bin/cat', 10:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:58 INFO - 'PWD': '/builds/slave/test', 10:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:58 INFO - 'SHELL': '/bin/bash', 10:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IelLpnwqDY/Listeners', 10:12:58 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 10:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:58 INFO - 'USER': 'cltbld', 10:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:58 INFO - 'XPC_FLAGS': '0x0', 10:12:58 INFO - 'XPC_SERVICE_NAME': '0', 10:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:58 INFO - Downloading/unpacking jsonschema 10:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:13:00 INFO - Downloading/unpacking functools32 (from jsonschema) 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:13:01 INFO - warning: no files found matching '*.txt' 10:13:01 INFO - no previously-included directories found matching 'build' 10:13:01 INFO - no previously-included directories found matching 'dist' 10:13:01 INFO - no previously-included directories found matching '.git*' 10:13:01 INFO - Installing collected packages: jsonschema, functools32 10:13:01 INFO - Running setup.py install for functools32 10:13:01 INFO - warning: no files found matching '*.txt' 10:13:01 INFO - no previously-included directories found matching 'build' 10:13:01 INFO - no previously-included directories found matching 'dist' 10:13:01 INFO - no previously-included directories found matching '.git*' 10:13:01 INFO - Successfully installed jsonschema functools32 10:13:01 INFO - Cleaning up... 10:13:01 INFO - Return code: 0 10:13:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d2ccddb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b03d30>, '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 0x108927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108afab20>, '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.CIc27o8R65/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.IelLpnwqDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 10:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:13:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CIc27o8R65/Render', 10:13:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:01 INFO - 'HOME': '/Users/cltbld', 10:13:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:01 INFO - 'LOGNAME': 'cltbld', 10:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:01 INFO - 'MOZ_NO_REMOTE': '1', 10:13:01 INFO - 'NO_EM_RESTART': '1', 10:13:01 INFO - 'PAGER': '/bin/cat', 10:13:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:01 INFO - 'PWD': '/builds/slave/test', 10:13:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:01 INFO - 'SHELL': '/bin/bash', 10:13:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IelLpnwqDY/Listeners', 10:13:01 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 10:13:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:01 INFO - 'USER': 'cltbld', 10:13:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:01 INFO - 'XPC_FLAGS': '0x0', 10:13:01 INFO - 'XPC_SERVICE_NAME': '0', 10:13:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:01 INFO - Downloading/unpacking flake8 10:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:13:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:13:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:13:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:13:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:13:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:13:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:13:05 INFO - no previously-included directories found matching 'docs/_build' 10:13:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:13:05 INFO - Running setup.py install for pep8 10:13:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:13:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:13:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:13:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:13:05 INFO - no previously-included directories found matching 'docs/_build' 10:13:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:13:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:13:05 INFO - Cleaning up... 10:13:05 INFO - Return code: 0 10:13:05 INFO - Running post-action listener: _resource_record_post_action 10:13:05 INFO - Running post-action listener: _start_resource_monitoring 10:13:05 INFO - Starting resource monitoring. 10:13:05 INFO - ##### 10:13:05 INFO - ##### Running install step. 10:13:05 INFO - ##### 10:13:05 INFO - Running pre-action listener: _resource_record_pre_action 10:13:05 INFO - Running main action method: install 10:13:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:06 INFO - Reading from file tmpfile_stdout 10:13:06 INFO - Detecting whether we're running mozinstall >=1.0... 10:13:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:13:06 INFO - Reading from file tmpfile_stdout 10:13:06 INFO - Output received: 10:13:06 INFO - Usage: mozinstall [options] installer 10:13:06 INFO - Options: 10:13:06 INFO - -h, --help show this help message and exit 10:13:06 INFO - -d DEST, --destination=DEST 10:13:06 INFO - Directory to install application into. [default: 10:13:06 INFO - "/builds/slave/test"] 10:13:06 INFO - --app=APP Application being installed. [default: firefox] 10:13:06 INFO - mkdir: /builds/slave/test/build/application 10:13:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:13:40 INFO - Reading from file tmpfile_stdout 10:13:40 INFO - Output received: 10:13:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:13:40 INFO - Running post-action listener: _resource_record_post_action 10:13:40 INFO - ##### 10:13:40 INFO - ##### Running run-tests step. 10:13:40 INFO - ##### 10:13:40 INFO - Running pre-action listener: _resource_record_pre_action 10:13:40 INFO - Running main action method: run_tests 10:13:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:13:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:13:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:13:40 INFO - 2016-02-23 10:13:40.884 screenresolution[1936:11934] starting screenresolution argv=screenresolution get 10:13:40 INFO - 2016-02-23 10:13:40.887 screenresolution[1936:11934] Display 0: 1600x1200x32@60 10:13:40 INFO - 2016-02-23 10:13:40.892 screenresolution[1937:11937] starting screenresolution argv=screenresolution list 10:13:40 INFO - Available Modes on Display 0 10:13:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:13:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:13:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:13:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:13:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:13:41 INFO - Intel Iris: 10:13:41 INFO - Chipset Model: Intel Iris 10:13:41 INFO - Type: GPU 10:13:41 INFO - Bus: Built-In 10:13:41 INFO - VRAM (Dynamic, Max): 1536 MB 10:13:41 INFO - Vendor: Intel (0x8086) 10:13:41 INFO - Device ID: 0x0a2e 10:13:41 INFO - Revision ID: 0x0009 10:13:41 INFO - Displays: 10:13:41 INFO - Display: 10:13:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:13:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:13:41 INFO - Display Serial Number: 1600x1200 60 10:13:41 INFO - Main Display: Yes 10:13:41 INFO - Mirror: Off 10:13:41 INFO - Online: Yes 10:13:41 INFO - Rotation: Supported 10:13:41 INFO - Return code: 0 10:13:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:41 INFO - Python 2.7.3 10:13:41 INFO - Return code: 0 10:13:41 INFO - grabbing minidump binary from tooltool 10:13: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')]} 10:13: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 0x108b03d30>, '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 0x108927db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108afab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13: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 10:13: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 10:13:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:41 INFO - Return code: 0 10:13:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:13:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:13:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:13:42 INFO - Return code: 0 10:13:42 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/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0186', '--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 10:13:42 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/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0186 --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 10:13:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CIc27o8R65/Render', 10:13:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:42 INFO - 'HOME': '/Users/cltbld', 10:13:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:42 INFO - 'LOGNAME': 'cltbld', 10:13:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:42 INFO - 'MOZ_NO_REMOTE': '1', 10:13:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:42 INFO - 'NO_EM_RESTART': '1', 10:13:42 INFO - 'PAGER': '/bin/cat', 10:13:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:42 INFO - 'PWD': '/builds/slave/test', 10:13:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:42 INFO - 'SHELL': '/bin/bash', 10:13:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IelLpnwqDY/Listeners', 10:13:42 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 10:13:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:42 INFO - 'USER': 'cltbld', 10:13:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:42 INFO - 'XPC_FLAGS': '0x0', 10:13:42 INFO - 'XPC_SERVICE_NAME': '0', 10:13:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:42 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/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0186', '--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 10:13:42 INFO - mozversion application_buildid: 20160223080008 10:13:42 INFO - mozversion application_changeset: 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 10:13:42 INFO - mozversion application_display_name: Nightly 10:13:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:13:42 INFO - mozversion application_name: Firefox 10:13:42 INFO - mozversion application_remotingname: firefox 10:13:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:13:42 INFO - mozversion application_vendor: Mozilla 10:13:42 INFO - mozversion application_version: 47.0a1 10:13:42 INFO - mozversion platform_buildid: 20160223080008 10:13:42 INFO - mozversion platform_changeset: 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 10:13:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:13:42 INFO - mozversion platform_version: 47.0a1 10:13:42 INFO - using testdate: 1456251222 10:13:42 INFO - actual date: 1456251222 10:13:42 INFO - starting webserver on 'localhost:49625' 10:13:42 INFO - SUITE-START | Running 2 tests 10:13:42 INFO - TEST-START | dromaeo_css 10:13:42 INFO - operating with platform_type : mac_ 10:13:42 INFO - Initialising browser for dromaeo_css test... 10:13:42 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmp2u0a2m/profile http://localhost:49625/getInfo.html) 10:13:44 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 10:13:44 INFO - PROCESS | 1955 | colorDepth:24 10:13:44 INFO - PROCESS | 1955 | Browser inner width/height: 1024/689 10:13:44 INFO - PROCESS | 1955 | __metrics 10:13:45 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" 10:13:45 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] 10:13:45 INFO - TEST-INFO | 1955: exit 0 10:13:45 INFO - Browser initialized. 10:13:45 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:45 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmp2u0a2m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:57 INFO - PROCESS | 1958 | RSS: Main: 242974720 10:13:57 INFO - PROCESS | 1958 | 10:14:49 INFO - PROCESS | 1958 | 1456251289303 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] 10:16:58 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49625/tests/dromaeo/cssquery-ext.html) 10:17:00 INFO - PROCESS | 1958 | RSS: Main: 400687104 10:17:00 INFO - PROCESS | 1958 | 10:20:02 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-ext.html (next: http://localhost:49625/tests/dromaeo/cssquery-jquery.html) 10:20:03 INFO - PROCESS | 1958 | RSS: Main: 380227584 10:20:03 INFO - PROCESS | 1958 | 10:23:05 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49625/tests/dromaeo/cssquery-mootools.html) 10:23:06 INFO - PROCESS | 1958 | RSS: Main: 375517184 10:23:06 INFO - PROCESS | 1958 | 10:26:08 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49625/tests/dromaeo/cssquery-prototype.html) 10:26:08 INFO - PROCESS | 1958 | RSS: Main: 335486976 10:26:08 INFO - PROCESS | 1958 | 10:29:12 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49625/tests/dromaeo/cssquery-yui.html) 10:29:12 INFO - PROCESS | 1958 | RSS: Main: 338628608 10:29:12 INFO - PROCESS | 1958 | 10:32:15 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-yui.html (next: http://localhost:49625/tests/dromaeo/cssquery-dojo.html) 10:32:15 INFO - PROCESS | 1958 | RSS: Main: 380145664 10:32:15 INFO - PROCESS | 1958 | 10:32:15 INFO - PROCESS | 1958 | __start_tp_report 10:32:15 INFO - PROCESS | 1958 | _x_x_mozilla_page_load 10:32:15 INFO - PROCESS | 1958 | _x_x_mozilla_page_load_details 10:32:15 INFO - PROCESS | 1958 | |i|pagename|runs| 10:32:15 INFO - PROCESS | 1958 | |0;dojo.html;3187.6015498062743;3314.320564284322;3451.188970591912;3489.813463422439;3521.383757842377;5529.253550770655;5574.554035677146;5605.943940560594;5607.439256074395;5619.185218143367;5587.552995760339;5635.774569017245;5650.208970744099;5724.112762521805;5726.656400615955;5061.089003979282;5097.490250974901;5125.871853203663;5136.383633963911;5239.10935141025;5203.427622961472;5223.764930578114;5273.367195936493;5286.656367336111;5317.149256119022;5075.416327122354;5090.872728181788;5153.458886816868;5170.069387510228;5181.093308671006;5159.561437277798;5161.664491808058;5161.767720452589;5189.6886186828915;5204.973975130138;5119.027384796914;5151.175811870083;5169.586433085382;5183.896322073575;5216.713080780555;5266.973665131688;5367.275417818583;5369.570434365241;5375.3012108425655;5382.730863456851;6044.274687037584;6068.440912811676;6082.178905847698;6097.57316987811;6113.205283313186;6122.693865306717;6152.969235153841;6160.476359509447;6171.938280617226;6218.81343559694;5617.662940223599;5633.521150702154;5693.544516438675;5705.400932902027;5723.885522289573;6324.968375158095;6352.904706429407;6360.904586431115;6368.840778980562;6374.075759014917;5867.941320586825;5977.193078934288;6015.518758499309;6023.156758053876;6132.6933653317155;6222.844428889314;6231.563790534619;6241.625502469867;6254.562180647311;6263.843403914939;6150.231221097363;6154.969225153845;6162.383761623802;6176.536759742948;6182;6030.91443540167;6111.942859700897;6144.78493252734;6166.075088736726;6199.101130336076;4813.687110337817;4828.806847726051;4833.830815921426;4860.562549370574;4865.489123642037;4250.277452833026;4307;4327.653787696977;4348.28253338202;4380.540043295472;5641.210230567724;5683.090705487102;5699.715014249271;5708.143778433186;5733.082706766897;5475.945240547623;5897.410258974154;6194.659293738798;6215.627062376272;6215.968920155461;5686.2607860977805;5688.203651488795;5688.516476099495;5699.629524081004;5699.943000570024;5233.476652334813;5275.788968441219;5279.102552566073;5296.4968328009545;5316.787328506894;6265.96867015662;6314.305426403183;6317.399847014526;6324.620522768649;6334.556581039283;6225.035119556476;6253.906191407042;6274.686265686789;6276.340984196776;6287.2769631492965;6225.564210505221;6277.12120303167;6293.118963345227;6323.525735569759;6328.050792381179;6052.878942421215;6064.848378790389;6067.605605635619;6068.302145253176;6119.388061194023;6200.627962322275;6210.3168651449205;6211.565190436626;6221.440070393686;6229.3770622937345;5895.322037965689;5935.554833387427;5989.011813050798;5994.490468310242;6014.188084608521;5941.970290148694;5949.791757288474;5961.970190149022;5963;5965.403459654;5766.971165144148;5829.242198514166;5833.533317334688;5833.970830145992;5837.562182836389;5945;5985.940140598713;6043.123747056564;6077.513798896166;6098.176746139392;5675.801346953002;5827.8834423310445;5839;5842.269716285465;5846.1815345852465 10:32:15 INFO - PROCESS | 1958 | |1;ext.html;436.356374347837;447.9395281636978;510.95401413872753;537.0547835808975;548.0217811206995;34828.4775728364;37489.625103748986;37564.812175939085;37643.43534846973;37740.43389349162;40503.797481012625;40638.9840253993;40696.59303406965;40778.79610601943;40834.59165408345;9388.953055234731;9605.807883842353;9617.326787124905;9631.036896310383;9632.855507167398;9432.245420366355;9580.137787599115;9596.808063838755;9680.90319096807;9710.854337184948;9646.75883102921;9674;9729.124378805906;9736.026397360278;9739.318247722662;9632.181264592484;9699.757506062335;9700.854487182698;9702.223822094216;9715.611375544935;9427.198688111519;9573.952130239304;9600;9602;9606.951965240129;39048.60951390478;39431.81704548868;39474.21051578952;39600.20799583992;39601.40597891034;3177.841107944617;3269.591301087364;3314.767966242364;3411.897643070687;3762.5108735864437;21853.781462185332;26308.73691263082;26378.340541486425;27146.049888253816;27299.590506142424;2730.494858451193;2741.424300896814;2809.1712944681367;2828.7736981041467;2904.651441826973;351739.2413037944;352342;353619;355032;355325;57193;58372.83254334889;63778.72442551123;64958.67520662461;65025.67487162534;50262;61504;61738.38261617416;61832;61873.690631547455;13519.256440895846;15877.920610396874;16090.517284481484;16115;16166;11997.820032699516;12011.459484323226;12013.579524716768;12015.339156346485;12015.879841201651;19878.60242795136;20163.596728065357;20167.899160504396;20234.291799786937;20268.087936042913;8880.37837351392;9032.683856065007;9055.773605659911;9146.451212927246;9163.129502697233;939.7321763297564;949.767307009787;957.4686049242737;1000.9749756256006;1093.9617113401152;27607.447851042867;28177.013804516744;28240.152795416172;28299.71700283012;28362;1079.7300674831292;1124.0389467005755;1143.2968724234536;1200.1418985425462;1247.2080229054616;14374;14452.410234874156;14554.12675239489;14736.410543578137;14790.630234244014;532722;535722.3213883906;538008;538677;539354;56278.71860640752;56735.71632141813;56828.43171568314;56954;57000.42999570034;1417.0647372733947;1419.4038503828417;1452.7167202395642;1455.7670772676322;1456.858418125354;28459.857700711364;28660.283492912844;28921.132366029055;28961.7103828959;29269.268268293465;44961.77519112515;48628.27057594068;49254.507454926425;49264.01471970469;49289;440236;442583;443476;443689;491055;31412.842935785175;31625.36749265048;31757.04728858138;31787;31933.042008739776;34059.65940340565;41142.9714257134;41700.58299416967;42255.7887210562;42714.78642606767;28422.193259728287;35421.46867796934;35616.643833561335;35795.64204358027;36428;36284.81857590695;36336.4549531752;36523.81738091292;38579.8426047219;39797.80101099592;31546.053618391485;32193.839030804695;38059;38097.42853857139;38134.046648834;26103.738962610132;28845;31787;31870.840645796623;32444.026679199662;21585.784142158376;22988.4252893679;23699.578025318537;24245.63631545493;24582.87708561446 10:32:15 INFO - PROCESS | 1958 | |2;jquery.html;356.52938121679387;356.9678728914398;357.4227622389841;361.9149499867531;363.93085313790397;15131.92434037831;15650.217489125527;18878;19431.805681943177;19859.50351241218;12298.877011229884;15584.766228506553;18464.907675461604;18877.96171210586;19030.714539281922;5458.426865179159;5631.014572449805;5795.739191736382;5798.478136967672;5804.709764511778;4127.153933443652;5524.640898341595;5672.376038635747;5678.545716342683;6123.387661233885;6320.873582528347;6335.176427064475;6337.619742815423;6341.968290158543;6342.682865856712;5495.395506494282;5734.856628584319;5742.2247996520355;6304.211973503312;6308.684565771716;5395.649282796606;5469.288992430998;5483.177523371526;5484.2596249506605;5486.451354864522;12439.875601243963;12797.552085677049;12821.615351539469;12836.743265134739;12867.42096605655;1955.227685064406;2031.7968203179712;2155.5796619659172;2663.3341664583854;2738.3564862257354;9342.346035777498;9430.962594114642;9592.856107158399;9913.008699130101;9969.651062212788;1739.5216315513335;1739.5651087228193;1755.6839768841603;1764.7970483394445;1796.5239211608935;84301.57849210776;100309;100907.99999999927;103394.48302758513;103951;10943.945280273547;11034.724131896766;11207.775844483065;11513.769724605461;11587.130965177645;13167.67080822987;13202.537911173255;13301.600951971457;13302;13316.201027938161;8173;8308.875366869503;8315.251627353568;8474.237318641352;8513.95743021281;8352.039515455679;8543.871841922377;8612.8708069379;8664;8763.69327073562;4382.627476664456;4462.219111655448;4470.329450582439;4495.483019452739;4495.910081798411;1853.935112271064;1902.6670332691724;1913.3781521005728;1943.475261679367;1946.3285166617495;927.7819712367589;934.8083642853198;940.4545363689044;1003.5935446144323;1065.8880817514205;18927.81072189288;19117.330893418664;19143.712844307345;19839.20643174257;20107.39677809668;945.8817647794026;947.8957314695378;957.7461972577272;1003.6035765872585;1018.4602160854758;10110.494475276208;10428.895711042944;10539.26225164231;10938.289011214245;11140.33158010522;469638;474498;515045;520337;520515.3845384645;126222.73777262293;130602.34698826446;130724.3463782675;133768.3311583436;133982.3300883509;920.7974245665943;956.2971216156259;1068.5992752717732;1100;1100.9339439633648;15506.612334691723;17632;17868.55328616795;18067.638647227246;18194.45416637503;43291;51808.481915181874;52107.47892521178;52215.73892130515;52915.47084529259;65096.02355964759;76224;77852.61073694595;81647.59176204081;85255;7777.338926191111;8013.799655008438;8091.109977902308;8199.754007379788;8282.751517454486;10959.12327013821;13292.534761283308;13333.533326333532;13490.123141995738;13631.795523066963;10160.74598135023;10317.019883111092;10975.46343511893;11542.19204655666;11808.409579520818;11521.423928803693;11525.250858694159;11556.191066625255;11680;11683.707907302045;11558.537658493566;11620.941895290469;11745.706357341134;11812.291262523931;11827.526898923947;7932.881006785018;7993;8057;8086.474379165335;8113.918860811316;9191.218746406363;11676.532938682358;11702.88297117052;11743.647690569296;11788.174827761974 10:32:15 INFO - PROCESS | 1958 | |3;mootools.html;1394.6304229379223;1489.7467430536808;1518.1194906953965;1533.8696210822077;1889.0743535667527;7816;8376.62305196266;8574.485530868153;8579.95710021449;8579.957100214506;8287.875681864776;8542.530160841152;8554.144585541442;8557.443766155211;8557.743267701964;2127.702121702963;2362.7755363240462;2386.4153282445827;2421.092090466075;2436.0986435019067;2444.168982545934;2450.4486490539666;2451.3626457121186;2455.6439316299125;2460.938476538092;1983.7817840037585;2407.38611654028;2408.915687950922;2414.7585241475886;2416.4925365673143;2346.4133966508375;2385.5586716457424;2399;2402.3633737059695;2404.2426635609813;2352.0826877517784;2372.632242002492;2385.260569223529;2398.568257713611;2398.6282126270457;8594.828103437958;8688.13118688126;8695.956520217422;8700.129987001312;8703.347248956354;4863.343448634424;5088.363954505687;5205.349331333583;5366.034113859504;5404.729763511808;3587.443946188345;3619.4208926571887;3669.669729724311;3694.1503454205413;3708.369577171887;1030.7835354575473;1047.675220681591;1053.778706471642;1081.1350919264557;1081.9451035240577;11531.904469075509;11700.771419001052;11721.882781172164;11727.824082638766;11730.882691173065;4791.161546729309;4802.542757078047;4853.708777473363;4854.538818812207;4870.732109733999;10008.599656013677;10032.347897386646;10036.498175091216;10043.096121348968;10047.59809607622;4754.809807607726;5362.91955620666;5377.139657654835;5401.432849550819;5408.594355423359;4407.471103467605;4721.220998535272;4877.097736918681;4883.536064073907;4892.461829198785;3864.5362556492837;3886.941695874564;3894.8636797711943;3924.038610540436;3963.722539422213;1244.954238439715;1260.8171815086762;1260.8865202131851;1262.4003598290922;1279.9168054076456;1286.5754301080622;1286.9292188929512;1299.857015728269;1300.655326338521;1356.7015256643522;8022.398320125897;8074.717384891501;8076.071251806;8077.313428358655;8110.31062359706;498.25759618168667;504.14547342254525;504.81321910893206;509.61524049342506;511.15148852904;6131.908021379683;6203.596766210272;6204.255489341218;6207.131001659771;6217.937820621826;10095.495225238708;10298.845517317246;10343.896561034293;10383.117435017957;10460.581576736997;9973.501324933724;10161.796764064677;10262.692119236435;10312.071913527818;10332.915043920431;8062.234087761653;8096.149904260085;8123.512589244546;8142.307903828241;8219.506829590244;6682.398584127452;7917.366610671248;7926;8028.43800933929;8112.22933821286;9330.436302789694;9474.099960503741;9564.521773911416;9595.28035397362;9686.9031309686;9669.419834809934;10026.147777438999;10036.498175091363;10142;10191.7452063699;6676.532642715158;6849.486288528281;7458.776236712907;7587.051618547682;7786.532808031537;8147.226013528705;8178.918210818054;8226.136255693305;8226.547539885363;8231.135730748185;6267.310595834363;7100.899360599115;7106.502544821813;7201.387882030086;7388.187299396955;6321;6872.759453419107;7065.364117229474;7223.9886415902865;7241.203467618452;7543.547387156788;7551.584662843597;7610.467267291237;7633.084029916446;7665.348445382205;6887.242403335529;6948.131483564554;6961.408280296231;6984.3364880336285;6992.405645520188;6915.412189963708;7035.366816986496;7073.71705131789;7084.326988936043;7095.9645201773665 10:32:15 INFO - PROCESS | 1958 | |4;prototype.html;310.492345015899;318.4331889237159;322.40677154036575;324.634785865901;326.476984865602;6422.229332480103;6511.674416279185;6571.080048793173;6586.07794908712;6602.10871532343;5252.185911183773;6407.006913928349;6462.192225971754;6470.223573171214;6497.967510162454;4615.630749540045;4693.131770622429;4714.269288260325;4841.007593443335;4863.732494712789;4776.570108690217;4811.422629284473;4820.662553621248;4828.61371090312;4829.444613869415;4756.833510827122;4759.167145749498;4819.662623616348;4825.927611085836;4841.612670986313;4553.521880202581;4655.534446555352;4770;4780.976095119502;4809.110314591811;4093.4678491795876;4095.508538975342;4112.157007813421;4116.567760385176;4118.979405102956;5475.589330800206;5650.7174641267775;6092.603980741238;6096.177016102858;6144.754209831602;5592.748326325325;5592.86017849553;5601.131824567158;5602.299712535933;5605.943940560583;6859.862802743967;6860.245373009015;6863.931360686429;6875.862482750367;6887.621180835052;4253.51084625269;4434.667399945017;4444.622207112399;4474.485434175046;4574.451065872084;7274.599897005663;7283.526570772883;7292.817679558;7305.232950540223;7306.196318405025;3790.086006566666;4555.883808466947;4568.383268258743;4577.542245775462;4579.381783459257;4629.67592268538;4630.467496237909;4633.62930965522;4635.629149668019;4650.116477869194;5470.632341914521;5478.808241711521;5480.534154596824;5483.369412517532;5486.670799752028;6663.100481435041;6948.722051117999;6963.7562685305775;6988.336108069725;7000.649967501605;1576.7398379267522;1598.7282162032482;1608;1608.549606110291;1609.4688752711577;952.1525842000625;970.4613939263777;1015.2334987084704;1017.1455976979373;1042.0309112525424;6438.066480360321;6553.639549824806;6577.967110164419;6579;6583.670816459158;7237.819054523679;7239.420846332281;7243.9637801811705;7247.13034435871;7251.274872512707;6548.639824809586;6550.7707230246715;6564.606123632598;6566.4418524425;6572.441342485847;3774.245150969817;3813.9427908581392;3815.294170578452;3817.026658202141;3817.7900215488417;7368.968344431783;7694.499857509356;7695.730649427355;7707.807304817312;7715.22549813546;7451.105867295959;7496.737614183587;7497.512661676974;7497.625118744041;7507.699692012258;7655.196204398458;7658.2724641159;7659.004329437137;7662.080550333995;7662.348700360309;6940.340667636567;7212.278772122746;7217.4586905983315;7259.12890453149;7261.310175533527;7024.08686870724;7083.256258093033;7098.6450677466955;7099.2190859006505;7101.964490177723;6957.243088732231;7618.961905190438;7639.923600763921;7640.465167438449;7643.082830060428;4104.548499665094;4578.084383123322;4578.725276483422;4580.381648477412;4591.47198072226;6881.380675739208;7172.605506697182;7194.820129496805;7202.171750248579;7207.27927207296;6885.449164066963;6937.583744975318;6951.443884489127;6963.721451141898;6964;6939.653017349214;6963.199232088375;6963.442924566124;6969.686364113526;6970.302969702989;5867.295924489089;6770.86458270822;6812.863742725217;6815.897761533482;6821;6553.737850485927;6892.758753443605;6914.585124892523;6933.618650974245;6942.826429339307;5753.626014309057;6489.772857949949;6540.724558711196;6636.568623039487;6836 10:32:15 INFO - PROCESS | 1958 | |5;yui.html;632.2949910849404;678.1455366238539;737.6680493777798;752;784.9018872640917;14628.414863405464;14973.401063957443;14986.950913436063;14989.550313490585;15010.399584016626;15305.693886122272;15735.527934161964;15746.606334841636;15749.921250393762;15770.684586308267;700.7652436433775;708.890122031086;835.4945258118842;868.7654333329997;873.9694110706126;850.9446885952393;862.1163307609719;862.2412277196058;865.7143142762873;866.7096522664915;909.295296145486;911.389369122686;912.4981260306838;913.1644545241096;913.4336711239008;725.7205975699368;733.9302766237199;734.0384096833166;905.1355955062932;907.1925985872579;660.2308310817939;668.8394785251553;668.906353110565;670;670.5105273150627;15027.323770430357;15088.698226035527;15116.470923517734;15124.168170750605;15135;12285.938570307091;12385.814212786816;12398.62804115878;12586.370681465982;12694.746105077847;10079.630869985845;10108.303249097484;10123.392596444164;10145.239107066925;10170.23723220754;3449.379111759882;3505.3515099706383;3506.211102501942;3517.4547945068557;3518.0501264658656;84884.15115848824;85565.57217213874;86482.56758716165;87178;87366;9005.954970225239;9040.683576074805;9147.81704365909;9208.770637085929;9270.44377337362;17999.01005444687;20125.698114528295;20827.687584686242;20897.79102208989;20901.059452324684;7387.889181662279;7393.371563417169;7461.477696561188;7582;7675.501092429086;4077.7757223353;4148.191102734938;4156.480439945007;4206.600372964564;4357.106793107406;3453.1712389026957;3502.6847583717586;3505.2638945821664;3512.5258090158013;3515.8945231643092;612.3539665652779;633.8605506788499;637.3021541412146;643.787550108463;646.7348387161242;507.0821812519352;561.1134407635925;598.5989387110646;630.3412933484519;638.4892086330917;8424.326053915673;8470.618822153017;8485.914261591517;8696.17386348296;8935.195832375117;575.4456737756951;599.6372194822158;601.3835818286292;603.9396060393925;624.341319907502;3850.5956874528333;3911;4013.6931930938563;4050.9392359114636;4097.569755175723;92956;94113;94454.52772736229;94720.52639736758;95016.52491737498;56868;78666;81319.59340203379;82478.58760706279;82564.76152857712;66261.66869165623;70155;72021;72320.2767972324;75494.62252688811;7192.091691687764;8746.344024198337;8854.203121719076;8874;8930.240929520804;47646;48864.2670359952;48876.77808054827;49947.251846186664;50409.74795126001;62903.05645415414;66338;68411;68836.6558167226;70723;11116.722081948015;11122.165837562054;11441.48513316886;11450.885491145315;11801.468933898166;11950.760984780081;12344.728646908756;12354.011679065832;12390.50311135955;12540.24758514492;8372.874406884024;11084.501197445972;11276.227256439939;11815.881841181823;12267;11768.798075967468;11770.94114529456;11898.881011190124;11965.700857478632;12325.876741232833;11255.021025155842;11269.943650282024;11387.829182562102;11471.082313415074;12308.569200077955;9366.250699943852;9529.475878826732;9721.951390243003;9731;9842.60629574809;7673;9684.32209745311;9770.511474426392;9913.752156196153;9998.800023999625 10:32:15 INFO - PROCESS | 1958 | __end_tp_report 10:32:15 INFO - PROCESS | 1958 | __start_cc_report 10:32:15 INFO - PROCESS | 1958 | _x_x_mozilla_cycle_collect,1886 10:32:15 INFO - PROCESS | 1958 | __end_cc_report 10:32:15 INFO - PROCESS | 1958 | __startTimestamp1456252335550__endTimestamp 10:32:15 INFO - PROCESS | 1958 | 10:32:15 INFO - PROCESS | 1958 | ------- Summary: start ------- 10:32:15 INFO - PROCESS | 1958 | Number of tests: 6 10:32:15 INFO - PROCESS | 1958 | 10:32:15 INFO - PROCESS | 1958 | [#0] dojo.html Cycles:165 Average:5674.21 Median:5837.56 stddev:633.72 (10.9%) stddev-sans-first:604.90 10:32:15 INFO - PROCESS | 1958 | Values: 3187.6 3314.3 3451.2 3489.8 3521.4 5529.3 5574.6 5605.9 5607.4 5619.2 5587.6 5635.8 5650.2 5724.1 5726.7 5061.1 5097.5 5125.9 5136.4 5239.1 5203.4 5223.8 5273.4 5286.7 5317.1 5075.4 5090.9 5153.5 5170.1 5181.1 5159.6 5161.7 5161.8 5189.7 5205.0 5119.0 5151.2 5169.6 5183.9 5216.7 5267.0 5367.3 5369.6 5375.3 5382.7 6044.3 6068.4 6082.2 6097.6 6113.2 6122.7 6153.0 6160.5 6171.9 6218.8 5617.7 5633.5 5693.5 5705.4 5723.9 6325.0 6352.9 6360.9 6368.8 6374.1 5867.9 5977.2 6015.5 6023.2 6132.7 6222.8 6231.6 6241.6 6254.6 6263.8 6150.2 6155.0 6162.4 6176.5 6182.0 6030.9 6111.9 6144.8 6166.1 6199.1 4813.7 4828.8 4833.8 4860.6 4865.5 4250.3 4307.0 4327.7 4348.3 4380.5 5641.2 5683.1 5699.7 5708.1 5733.1 5475.9 5897.4 6194.7 6215.6 6216.0 5686.3 5688.2 5688.5 5699.6 5699.9 5233.5 5275.8 5279.1 5296.5 5316.8 6266.0 6314.3 6317.4 6324.6 6334.6 6225.0 6253.9 6274.7 6276.3 6287.3 6225.6 6277.1 6293.1 6323.5 6328.1 6052.9 6064.8 6067.6 6068.3 6119.4 6200.6 6210.3 6211.6 6221.4 6229.4 5895.3 5935.6 5989.0 5994.5 6014.2 5942.0 5949.8 5962.0 5963.0 5965.4 5767.0 5829.2 5833.5 5834.0 5837.6 5945.0 5985.9 6043.1 6077.5 6098.2 5675.8 5827.9 5839.0 5842.3 5846.2 10:32:15 INFO - PROCESS | 1958 | 10:32:15 INFO - PROCESS | 1958 | [#1] ext.html Cycles:180 Average:59220.37 Median:20702.97 stddev:120672.40 (582.9%) stddev-sans-first:120930.21 10:32:15 INFO - PROCESS | 1958 | Values: 436.4 447.9 511.0 537.1 548.0 34828.5 37489.6 37564.8 37643.4 37740.4 40503.8 40639.0 40696.6 40778.8 40834.6 9389.0 9605.8 9617.3 9631.0 9632.9 9432.2 9580.1 9596.8 9680.9 9710.9 9646.8 9674.0 9729.1 9736.0 9739.3 9632.2 9699.8 9700.9 9702.2 9715.6 9427.2 9574.0 9600.0 9602.0 9607.0 39048.6 39431.8 39474.2 39600.2 39601.4 3177.8 3269.6 3314.8 3411.9 3762.5 21853.8 26308.7 26378.3 27146.0 27299.6 2730.5 2741.4 2809.2 2828.8 2904.7 351739.2 352342.0 353619.0 355032.0 355325.0 57193.0 58372.8 63778.7 64958.7 65025.7 50262.0 61504.0 61738.4 61832.0 61873.7 13519.3 15877.9 16090.5 16115.0 16166.0 11997.8 12011.5 12013.6 12015.3 12015.9 19878.6 20163.6 20167.9 20234.3 20268.1 8880.4 9032.7 9055.8 9146.5 9163.1 939.7 949.8 957.5 1001.0 1094.0 27607.4 28177.0 28240.2 28299.7 28362.0 1079.7 1124.0 1143.3 1200.1 1247.2 14374.0 14452.4 14554.1 14736.4 14790.6 532722.0 535722.3 538008.0 538677.0 539354.0 56278.7 56735.7 56828.4 56954.0 57000.4 1417.1 1419.4 1452.7 1455.8 1456.9 28459.9 28660.3 28921.1 28961.7 29269.3 44961.8 48628.3 49254.5 49264.0 49289.0 440236.0 442583.0 443476.0 443689.0 491055.0 31412.8 31625.4 31757.0 31787.0 31933.0 34059.7 41143.0 41700.6 42255.8 42714.8 28422.2 35421.5 35616.6 35795.6 36428.0 36284.8 36336.5 36523.8 38579.8 39797.8 31546.1 32193.8 38059.0 38097.4 38134.0 26103.7 28845.0 31787.0 31870.8 32444.0 21585.8 22988.4 23699.6 24245.6 24582.9 10:32:15 INFO - PROCESS | 1958 | 10:32:15 INFO - PROCESS | 1958 | [#2] jquery.html Cycles:180 Average:31124.88 Median:11069.60 stddev:84283.11 (761.4%) stddev-sans-first:84487.89 10:32:15 INFO - PROCESS | 1958 | Values: 356.5 357.0 357.4 361.9 363.9 15131.9 15650.2 18878.0 19431.8 19859.5 12298.9 15584.8 18464.9 18878.0 19030.7 5458.4 5631.0 5795.7 5798.5 5804.7 4127.2 5524.6 5672.4 5678.5 6123.4 6320.9 6335.2 6337.6 6342.0 6342.7 5495.4 5734.9 5742.2 6304.2 6308.7 5395.6 5469.3 5483.2 5484.3 5486.5 12439.9 12797.6 12821.6 12836.7 12867.4 1955.2 2031.8 2155.6 2663.3 2738.4 9342.3 9431.0 9592.9 9913.0 9969.7 1739.5 1739.6 1755.7 1764.8 1796.5 84301.6 100309.0 100908.0 103394.5 103951.0 10943.9 11034.7 11207.8 11513.8 11587.1 13167.7 13202.5 13301.6 13302.0 13316.2 8173.0 8308.9 8315.3 8474.2 8514.0 8352.0 8543.9 8612.9 8664.0 8763.7 4382.6 4462.2 4470.3 4495.5 4495.9 1853.9 1902.7 1913.4 1943.5 1946.3 927.8 934.8 940.5 1003.6 1065.9 18927.8 19117.3 19143.7 19839.2 20107.4 945.9 947.9 957.7 1003.6 1018.5 10110.5 10428.9 10539.3 10938.3 11140.3 469638.0 474498.0 515045.0 520337.0 520515.4 126222.7 130602.3 130724.3 133768.3 133982.3 920.8 956.3 1068.6 1100.0 1100.9 15506.6 17632.0 17868.6 18067.6 18194.5 43291.0 51808.5 52107.5 52215.7 52915.5 65096.0 76224.0 77852.6 81647.6 85255.0 7777.3 8013.8 8091.1 8199.8 8282.8 10959.1 13292.5 13333.5 13490.1 13631.8 10160.7 10317.0 10975.5 11542.2 11808.4 11521.4 11525.3 11556.2 11680.0 11683.7 11558.5 11620.9 11745.7 11812.3 11827.5 7932.9 7993.0 8057.0 8086.5 8113.9 9191.2 11676.5 11702.9 11743.6 11788.2 10:32:15 INFO - PROCESS | 1958 | 10:32:15 INFO - PROCESS | 1958 | [#3] mootools.html Cycles:180 Average:5935.94 Median:501.20 stddev:3156.53 (629.8%) stddev-sans-first:3146.93 10:32:15 INFO - PROCESS | 1958 | Values: 1394.6 1489.7 1518.1 1533.9 1889.1 7816.0 8376.6 8574.5 8580.0 8580.0 8287.9 8542.5 8554.1 8557.4 8557.7 2127.7 2362.8 2386.4 2421.1 2436.1 2444.2 2450.4 2451.4 2455.6 2460.9 1983.8 2407.4 2408.9 2414.8 2416.5 2346.4 2385.6 2399.0 2402.4 2404.2 2352.1 2372.6 2385.3 2398.6 2398.6 8594.8 8688.1 8696.0 8700.1 8703.3 4863.3 5088.4 5205.3 5366.0 5404.7 3587.4 3619.4 3669.7 3694.2 3708.4 1030.8 1047.7 1053.8 1081.1 1081.9 11531.9 11700.8 11721.9 11727.8 11730.9 4791.2 4802.5 4853.7 4854.5 4870.7 10008.6 10032.3 10036.5 10043.1 10047.6 4754.8 5362.9 5377.1 5401.4 5408.6 4407.5 4721.2 4877.1 4883.5 4892.5 3864.5 3886.9 3894.9 3924.0 3963.7 1245.0 1260.8 1260.9 1262.4 1279.9 1286.6 1286.9 1299.9 1300.7 1356.7 8022.4 8074.7 8076.1 8077.3 8110.3 498.3 504.1 504.8 509.6 511.2 6131.9 6203.6 6204.3 6207.1 6217.9 10095.5 10298.8 10343.9 10383.1 10460.6 9973.5 10161.8 10262.7 10312.1 10332.9 8062.2 8096.1 8123.5 8142.3 8219.5 6682.4 7917.4 7926.0 8028.4 8112.2 9330.4 9474.1 9564.5 9595.3 9686.9 9669.4 10026.1 10036.5 10142.0 10191.7 6676.5 6849.5 7458.8 7587.1 7786.5 8147.2 8178.9 8226.1 8226.5 8231.1 6267.3 7100.9 7106.5 7201.4 7388.2 6321.0 6872.8 7065.4 7224.0 7241.2 7543.5 7551.6 7610.5 7633.1 7665.3 6887.2 6948.1 6961.4 6984.3 6992.4 6915.4 7035.4 7073.7 7084.3 7096.0 10:32:15 INFO - PROCESS | 1958 | 10:32:15 INFO - PROCESS | 1958 | [#4] prototype.html Cycles:180 Average:5681.40 Median:6549.71 stddev:1834.75 (28.0%) stddev-sans-first:1795.07 10:32:15 INFO - PROCESS | 1958 | Values: 310.5 318.4 322.4 324.6 326.5 6422.2 6511.7 6571.1 6586.1 6602.1 5252.2 6407.0 6462.2 6470.2 6498.0 4615.6 4693.1 4714.3 4841.0 4863.7 4776.6 4811.4 4820.7 4828.6 4829.4 4756.8 4759.2 4819.7 4825.9 4841.6 4553.5 4655.5 4770.0 4781.0 4809.1 4093.5 4095.5 4112.2 4116.6 4119.0 5475.6 5650.7 6092.6 6096.2 6144.8 5592.7 5592.9 5601.1 5602.3 5605.9 6859.9 6860.2 6863.9 6875.9 6887.6 4253.5 4434.7 4444.6 4474.5 4574.5 7274.6 7283.5 7292.8 7305.2 7306.2 3790.1 4555.9 4568.4 4577.5 4579.4 4629.7 4630.5 4633.6 4635.6 4650.1 5470.6 5478.8 5480.5 5483.4 5486.7 6663.1 6948.7 6963.8 6988.3 7000.6 1576.7 1598.7 1608.0 1608.5 1609.5 952.2 970.5 1015.2 1017.1 1042.0 6438.1 6553.6 6578.0 6579.0 6583.7 7237.8 7239.4 7244.0 7247.1 7251.3 6548.6 6550.8 6564.6 6566.4 6572.4 3774.2 3813.9 3815.3 3817.0 3817.8 7369.0 7694.5 7695.7 7707.8 7715.2 7451.1 7496.7 7497.5 7497.6 7507.7 7655.2 7658.3 7659.0 7662.1 7662.3 6940.3 7212.3 7217.5 7259.1 7261.3 7024.1 7083.3 7098.6 7099.2 7102.0 6957.2 7619.0 7639.9 7640.5 7643.1 4104.5 4578.1 4578.7 4580.4 4591.5 6881.4 7172.6 7194.8 7202.2 7207.3 6885.4 6937.6 6951.4 6963.7 6964.0 6939.7 6963.2 6963.4 6969.7 6970.3 5867.3 6770.9 6812.9 6815.9 6821.0 6553.7 6892.8 6914.6 6933.6 6942.8 5753.6 6489.8 6540.7 6636.6 6836.0 10:32:15 INFO - PROCESS | 1958 | 10:32:15 INFO - PROCESS | 1958 | [#5] yui.html Cycles:180 Average:18497.13 Median:631.32 stddev:26200.76 (4150.2%) stddev-sans-first:26239.92 10:32:15 INFO - PROCESS | 1958 | Values: 632.3 678.1 737.7 752.0 784.9 14628.4 14973.4 14987.0 14989.6 15010.4 15305.7 15735.5 15746.6 15749.9 15770.7 700.8 708.9 835.5 868.8 874.0 850.9 862.1 862.2 865.7 866.7 909.3 911.4 912.5 913.2 913.4 725.7 733.9 734.0 905.1 907.2 660.2 668.8 668.9 670.0 670.5 15027.3 15088.7 15116.5 15124.2 15135.0 12285.9 12385.8 12398.6 12586.4 12694.7 10079.6 10108.3 10123.4 10145.2 10170.2 3449.4 3505.4 3506.2 3517.5 3518.1 84884.2 85565.6 86482.6 87178.0 87366.0 9006.0 9040.7 9147.8 9208.8 9270.4 17999.0 20125.7 20827.7 20897.8 20901.1 7387.9 7393.4 7461.5 7582.0 7675.5 4077.8 4148.2 4156.5 4206.6 4357.1 3453.2 3502.7 3505.3 3512.5 3515.9 612.4 633.9 637.3 643.8 646.7 507.1 561.1 598.6 630.3 638.5 8424.3 8470.6 8485.9 8696.2 8935.2 575.4 599.6 601.4 603.9 624.3 3850.6 3911.0 4013.7 4050.9 4097.6 92956.0 94113.0 94454.5 94720.5 95016.5 56868.0 78666.0 81319.6 82478.6 82564.8 66261.7 70155.0 72021.0 72320.3 75494.6 7192.1 8746.3 8854.2 8874.0 8930.2 47646.0 48864.3 48876.8 49947.3 50409.7 62903.1 66338.0 68411.0 68836.7 70723.0 11116.7 11122.2 11441.5 11450.9 11801.5 11950.8 12344.7 12354.0 12390.5 12540.2 8372.9 11084.5 11276.2 11815.9 12267.0 11768.8 11770.9 11898.9 11965.7 12325.9 11255.0 11269.9 11387.8 11471.1 12308.6 9366.3 9529.5 9722.0 9731.0 9842.6 7673.0 9684.3 9770.5 9913.8 9998.8 10:32:15 INFO - PROCESS | 1958 | -------- Summary: end -------- 10:32:15 INFO - PROCESS | 1958 | 10:32:16 INFO - TEST-INFO | 1958: exit 0 10:32:16 INFO - TEST-OK | dromaeo_css | took 1113458ms 10:32:16 INFO - TEST-START | kraken 10:32:16 INFO - operating with platform_type : mac_ 10:32:16 INFO - Initialising browser for kraken test... 10:32:16 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpwsr_MO/profile http://localhost:49625/getInfo.html) 10:32:18 INFO - PROCESS | 1963 | __metrics Screen width/height:1600/1200 10:32:18 INFO - PROCESS | 1963 | colorDepth:24 10:32:18 INFO - PROCESS | 1963 | Browser inner width/height: 1024/689 10:32:18 INFO - PROCESS | 1963 | __metrics 10:32:18 INFO - PROCESS | 1963 | 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" 10:32:18 INFO - PROCESS | 1963 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:32:19 INFO - TEST-INFO | 1963: exit 0 10:32:19 INFO - Browser initialized. 10:32:19 INFO - Running cycle 1/1 for kraken test... 10:32:19 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpwsr_MO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:31 INFO - PROCESS | 1965 | RSS: Main: 242892800 10:32:31 INFO - PROCESS | 1965 | 10:32:33 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49625/tests/kraken/driver.html?testName=audio-beat-detection) 10:32:34 INFO - PROCESS | 1965 | RSS: Main: 290320384 10:32:34 INFO - PROCESS | 1965 | 10:32:36 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49625/tests/kraken/driver.html?testName=audio-dft) 10:32:37 INFO - PROCESS | 1965 | RSS: Main: 301113344 10:32:37 INFO - PROCESS | 1965 | 10:32:40 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49625/tests/kraken/driver.html?testName=audio-fft) 10:32:41 INFO - PROCESS | 1965 | RSS: Main: 284913664 10:32:41 INFO - PROCESS | 1965 | 10:32:43 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49625/tests/kraken/driver.html?testName=audio-oscillator) 10:32:44 INFO - PROCESS | 1965 | RSS: Main: 287961088 10:32:44 INFO - PROCESS | 1965 | 10:32:46 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:32:46 INFO - PROCESS | 1965 | RSS: Main: 288272384 10:32:46 INFO - PROCESS | 1965 | 10:32:49 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49625/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:50 INFO - PROCESS | 1965 | RSS: Main: 289304576 10:32:50 INFO - PROCESS | 1965 | 10:32:53 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49625/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:53 INFO - PROCESS | 1965 | RSS: Main: 289628160 10:32:53 INFO - PROCESS | 1965 | 10:32:56 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49625/tests/kraken/driver.html?testName=json-parse-financial) 10:32:57 INFO - PROCESS | 1965 | RSS: Main: 289689600 10:32:57 INFO - PROCESS | 1965 | 10:32:58 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:59 INFO - PROCESS | 1965 | RSS: Main: 323170304 10:32:59 INFO - PROCESS | 1965 | 10:33:01 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:33:01 INFO - PROCESS | 1965 | RSS: Main: 322039808 10:33:01 INFO - PROCESS | 1965 | 10:33:04 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:33:04 INFO - PROCESS | 1965 | RSS: Main: 332505088 10:33:04 INFO - PROCESS | 1965 | 10:33:07 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:33:07 INFO - PROCESS | 1965 | RSS: Main: 333959168 10:33:07 INFO - PROCESS | 1965 | 10:33:10 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:33:11 INFO - PROCESS | 1965 | RSS: Main: 332238848 10:33:11 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49625/tests/kraken/driver.html?testName=ai-astar) 10:33:12 INFO - PROCESS | 1965 | RSS: Main: 393629696 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | __start_tp_report 10:33:12 INFO - PROCESS | 1965 | _x_x_mozilla_page_load 10:33:12 INFO - PROCESS | 1965 | _x_x_mozilla_page_load_details 10:33:12 INFO - PROCESS | 1965 | |i|pagename|runs| 10:33:12 INFO - PROCESS | 1965 | |0;ai-astar;112;108;112;112;111;112;116;111;111;111 10:33:12 INFO - PROCESS | 1965 | |1;audio-beat-detection;157;120;146;158;118;146;137;118;176;152 10:33:12 INFO - PROCESS | 1965 | |2;audio-dft;186;188;184;187;187;185;187;181;182;184 10:33:12 INFO - PROCESS | 1965 | |3;audio-fft;73;104;118;77;75;81;89;109;76;57 10:33:12 INFO - PROCESS | 1965 | |4;audio-oscillator;95;93;121;79;104;121;148;76;79;138 10:33:12 INFO - PROCESS | 1965 | |5;imaging-gaussian-blur;88;95;89;94;87;93;87;94;87;93 10:33:12 INFO - PROCESS | 1965 | |6;imaging-darkroom;104;149;121;96;96;97;96;96;96;104 10:33:12 INFO - PROCESS | 1965 | |7;imaging-desaturate;127;142;88;85;85;88;85;85;85;90 10:33:12 INFO - PROCESS | 1965 | |8;json-parse-financial;57;55;55;54;53;53;55;66;52;52 10:33:12 INFO - PROCESS | 1965 | |9;json-stringify-tinderbox;64;71;75;71;71;67;68;69;67;69 10:33:12 INFO - PROCESS | 1965 | |10;stanford-crypto-aes;82;83;95;107;75;98;96;107;110;108 10:33:12 INFO - PROCESS | 1965 | |11;stanford-crypto-ccm;123;145;143;126;121;124;124;124;127;122 10:33:12 INFO - PROCESS | 1965 | |12;stanford-crypto-pbkdf2;141;127;138;137;136;143;135;130;138;139 10:33:12 INFO - PROCESS | 1965 | |13;stanford-crypto-sha256-iterative;64;65;65;68;67;67;66;66;67;66 10:33:12 INFO - PROCESS | 1965 | __end_tp_report 10:33:12 INFO - PROCESS | 1965 | __start_cc_report 10:33:12 INFO - PROCESS | 1965 | _x_x_mozilla_cycle_collect,1158 10:33:12 INFO - PROCESS | 1965 | __end_cc_report 10:33:12 INFO - PROCESS | 1965 | __startTimestamp1456252392945__endTimestamp 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | ------- Summary: start ------- 10:33:12 INFO - PROCESS | 1965 | Number of tests: 14 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.96 (1.7%) stddev-sans-first:2.07 10:33:12 INFO - PROCESS | 1965 | Values: 112.0 108.0 112.0 112.0 111.0 112.0 116.0 111.0 111.0 111.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:149.00 stddev:19.50 (13.1%) stddev-sans-first:20.00 10:33:12 INFO - PROCESS | 1965 | Values: 157.0 120.0 146.0 158.0 118.0 146.0 137.0 118.0 176.0 152.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#2] audio-dft Cycles:10 Average:185.10 Median:186.50 stddev:2.33 (1.2%) stddev-sans-first:2.45 10:33:12 INFO - PROCESS | 1965 | Values: 186.0 188.0 184.0 187.0 187.0 185.0 187.0 181.0 182.0 184.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#3] audio-fft Cycles:10 Average:85.90 Median:75.50 stddev:18.92 (25.1%) stddev-sans-first:19.49 10:33:12 INFO - PROCESS | 1965 | Values: 73.0 104.0 118.0 77.0 75.0 81.0 89.0 109.0 76.0 57.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:77.50 stddev:25.57 (33.0%) stddev-sans-first:26.85 10:33:12 INFO - PROCESS | 1965 | Values: 95.0 93.0 121.0 79.0 104.0 121.0 148.0 76.0 79.0 138.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:93.00 stddev:3.37 (3.6%) stddev-sans-first:3.43 10:33:12 INFO - PROCESS | 1965 | Values: 88.0 95.0 89.0 94.0 87.0 93.0 87.0 94.0 87.0 93.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#6] imaging-darkroom Cycles:10 Average:105.50 Median:96.00 stddev:17.19 (17.9%) stddev-sans-first:18.23 10:33:12 INFO - PROCESS | 1965 | Values: 104.0 149.0 121.0 96.0 96.0 97.0 96.0 96.0 96.0 104.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:85.00 stddev:20.67 (24.3%) stddev-sans-first:18.64 10:33:12 INFO - PROCESS | 1965 | Values: 127.0 142.0 88.0 85.0 85.0 88.0 85.0 85.0 85.0 90.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:4.10 (7.5%) stddev-sans-first:4.30 10:33:12 INFO - PROCESS | 1965 | Values: 57.0 55.0 55.0 54.0 53.0 53.0 55.0 66.0 52.0 52.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:70.00 stddev:3.01 (4.3%) stddev-sans-first:2.54 10:33:12 INFO - PROCESS | 1965 | Values: 64.0 71.0 75.0 71.0 71.0 67.0 68.0 69.0 67.0 69.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#10] stanford-crypto-aes Cycles:10 Average:96.10 Median:82.50 stddev:12.44 (15.1%) stddev-sans-first:12.10 10:33:12 INFO - PROCESS | 1965 | Values: 82.0 83.0 95.0 107.0 75.0 98.0 96.0 107.0 110.0 108.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:125.00 stddev:8.67 (6.9%) stddev-sans-first:9.02 10:33:12 INFO - PROCESS | 1965 | Values: 123.0 145.0 143.0 126.0 121.0 124.0 124.0 124.0 127.0 122.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.40 Median:138.00 stddev:4.81 (3.5%) stddev-sans-first:4.81 10:33:12 INFO - PROCESS | 1965 | Values: 141.0 127.0 138.0 137.0 136.0 143.0 135.0 130.0 138.0 139.0 10:33:12 INFO - PROCESS | 1965 | 10:33:12 INFO - PROCESS | 1965 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.20 (1.8%) stddev-sans-first:1.00 10:33:12 INFO - PROCESS | 1965 | Values: 64.0 65.0 65.0 68.0 67.0 67.0 66.0 66.0 67.0 66.0 10:33:12 INFO - PROCESS | 1965 | -------- Summary: end -------- 10:33:12 INFO - PROCESS | 1965 | 10:33:13 INFO - TEST-INFO | 1965: exit 0 10:33:13 INFO - TEST-OK | kraken | took 57511ms 10:33:13 INFO - SUITE-END | took 1170s 10:33:14 INFO - Completed test suite (00:19:31) 10:33:14 INFO - Working with test: dromaeo_css 10:33:14 INFO - Generating results file: dromaeo_css 10:33:14 INFO - Working with test: kraken 10:33:14 INFO - Generating results file: kraken 10:33:14 INFO - javascript benchmark 10:33:14 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:33:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 10:33:14 INFO - process_Request line: dromaeo_css 7391.70 graph.html#tests=[[72,64,59]] 10:33:14 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:33:14 INFO - process_Request line: kraken 1473.90 graph.html#tests=[[232,64,59]] 10:33:14 INFO - RETURN: dromaeo_css: 7391.70 10:33:14 INFO - RETURN: kraken: 1473.90 10:33:14 INFO - javascript benchmark 10:33:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3187.6015498062743, 3314.320564284322, 3451.188970591912, 3489.813463422439, 3521.383757842377, 5529.253550770655, 5574.554035677146, 5605.943940560594, 5607.439256074395, 5619.185218143367, 5587.552995760339, 5635.774569017245, 5650.208970744099, 5724.112762521805, 5726.656400615955, 5061.089003979282, 5097.490250974901, 5125.871853203663, 5136.383633963911, 5239.10935141025, 5203.427622961472, 5223.764930578114, 5273.367195936493, 5286.656367336111, 5317.149256119022, 5075.416327122354, 5090.872728181788, 5153.458886816868, 5170.069387510228, 5181.093308671006, 5159.561437277798, 5161.664491808058, 5161.767720452589, 5189.6886186828915, 5204.973975130138, 5119.027384796914, 5151.175811870083, 5169.586433085382, 5183.896322073575, 5216.713080780555, 5266.973665131688, 5367.275417818583, 5369.570434365241, 5375.3012108425655, 5382.730863456851, 6044.274687037584, 6068.440912811676, 6082.178905847698, 6097.57316987811, 6113.205283313186, 6122.693865306717, 6152.969235153841, 6160.476359509447, 6171.938280617226, 6218.81343559694, 5617.662940223599, 5633.521150702154, 5693.544516438675, 5705.400932902027, 5723.885522289573, 6324.968375158095, 6352.904706429407, 6360.904586431115, 6368.840778980562, 6374.075759014917, 5867.941320586825, 5977.193078934288, 6015.518758499309, 6023.156758053876, 6132.6933653317155, 6222.844428889314, 6231.563790534619, 6241.625502469867, 6254.562180647311, 6263.843403914939, 6150.231221097363, 6154.969225153845, 6162.383761623802, 6176.536759742948, 6182.0, 6030.91443540167, 6111.942859700897, 6144.78493252734, 6166.075088736726, 6199.101130336076, 4813.687110337817, 4828.806847726051, 4833.830815921426, 4860.562549370574, 4865.489123642037, 4250.277452833026, 4307.0, 4327.653787696977, 4348.28253338202, 4380.540043295472, 5641.210230567724, 5683.090705487102, 5699.715014249271, 5708.143778433186, 5733.082706766897, 5475.945240547623, 5897.410258974154, 6194.659293738798, 6215.627062376272, 6215.968920155461, 5686.2607860977805, 5688.203651488795, 5688.516476099495, 5699.629524081004, 5699.943000570024, 5233.476652334813, 5275.788968441219, 5279.102552566073, 5296.4968328009545, 5316.787328506894, 6265.96867015662, 6314.305426403183, 6317.399847014526, 6324.620522768649, 6334.556581039283, 6225.035119556476, 6253.906191407042, 6274.686265686789, 6276.340984196776, 6287.2769631492965, 6225.564210505221, 6277.12120303167, 6293.118963345227, 6323.525735569759, 6328.050792381179, 6052.878942421215, 6064.848378790389, 6067.605605635619, 6068.302145253176, 6119.388061194023, 6200.627962322275, 6210.3168651449205, 6211.565190436626, 6221.440070393686, 6229.3770622937345, 5895.322037965689, 5935.554833387427, 5989.011813050798, 5994.490468310242, 6014.188084608521, 5941.970290148694, 5949.791757288474, 5961.970190149022, 5963.0, 5965.403459654, 5766.971165144148, 5829.242198514166, 5833.533317334688, 5833.970830145992, 5837.562182836389, 5945.0, 5985.940140598713, 6043.123747056564, 6077.513798896166, 6098.176746139392, 5675.801346953002, 5827.8834423310445, 5839.0, 5842.269716285465, 5846.1815345852465], "unit": "score", "name": "dojo.html", "value": 5633.364475071671}, {"lowerIsBetter": false, "replicates": [436.356374347837, 447.9395281636978, 510.95401413872753, 537.0547835808975, 548.0217811206995, 34828.4775728364, 37489.625103748986, 37564.812175939085, 37643.43534846973, 37740.43389349162, 40503.797481012625, 40638.9840253993, 40696.59303406965, 40778.79610601943, 40834.59165408345, 9388.953055234731, 9605.807883842353, 9617.326787124905, 9631.036896310383, 9632.855507167398, 9432.245420366355, 9580.137787599115, 9596.808063838755, 9680.90319096807, 9710.854337184948, 9646.75883102921, 9674.0, 9729.124378805906, 9736.026397360278, 9739.318247722662, 9632.181264592484, 9699.757506062335, 9700.854487182698, 9702.223822094216, 9715.611375544935, 9427.198688111519, 9573.952130239304, 9600.0, 9602.0, 9606.951965240129, 39048.60951390478, 39431.81704548868, 39474.21051578952, 39600.20799583992, 39601.40597891034, 3177.841107944617, 3269.591301087364, 3314.767966242364, 3411.897643070687, 3762.5108735864437, 21853.781462185332, 26308.73691263082, 26378.340541486425, 27146.049888253816, 27299.590506142424, 2730.494858451193, 2741.424300896814, 2809.1712944681367, 2828.7736981041467, 2904.651441826973, 351739.2413037944, 352342.0, 353619.0, 355032.0, 355325.0, 57193.0, 58372.83254334889, 63778.72442551123, 64958.67520662461, 65025.67487162534, 50262.0, 61504.0, 61738.38261617416, 61832.0, 61873.690631547455, 13519.256440895846, 15877.920610396874, 16090.517284481484, 16115.0, 16166.0, 11997.820032699516, 12011.459484323226, 12013.579524716768, 12015.339156346485, 12015.879841201651, 19878.60242795136, 20163.596728065357, 20167.899160504396, 20234.291799786937, 20268.087936042913, 8880.37837351392, 9032.683856065007, 9055.773605659911, 9146.451212927246, 9163.129502697233, 939.7321763297564, 949.767307009787, 957.4686049242737, 1000.9749756256006, 1093.9617113401152, 27607.447851042867, 28177.013804516744, 28240.152795416172, 28299.71700283012, 28362.0, 1079.7300674831292, 1124.0389467005755, 1143.2968724234536, 1200.1418985425462, 1247.2080229054616, 14374.0, 14452.410234874156, 14554.12675239489, 14736.410543578137, 14790.630234244014, 532722.0, 535722.3213883906, 538008.0, 538677.0, 539354.0, 56278.71860640752, 56735.71632141813, 56828.43171568314, 56954.0, 57000.42999570034, 1417.0647372733947, 1419.4038503828417, 1452.7167202395642, 1455.7670772676322, 1456.858418125354, 28459.857700711364, 28660.283492912844, 28921.132366029055, 28961.7103828959, 29269.268268293465, 44961.77519112515, 48628.27057594068, 49254.507454926425, 49264.01471970469, 49289.0, 440236.0, 442583.0, 443476.0, 443689.0, 491055.0, 31412.842935785175, 31625.36749265048, 31757.04728858138, 31787.0, 31933.042008739776, 34059.65940340565, 41142.9714257134, 41700.58299416967, 42255.7887210562, 42714.78642606767, 28422.193259728287, 35421.46867796934, 35616.643833561335, 35795.64204358027, 36428.0, 36284.81857590695, 36336.4549531752, 36523.81738091292, 38579.8426047219, 39797.80101099592, 31546.053618391485, 32193.839030804695, 38059.0, 38097.42853857139, 38134.046648834, 26103.738962610132, 28845.0, 31787.0, 31870.840645796623, 32444.026679199662, 21585.784142158376, 22988.4252893679, 23699.578025318537, 24245.63631545493, 24582.87708561446], "unit": "score", "name": "ext.html", "value": 19148.313645979844}, {"lowerIsBetter": false, "replicates": [356.52938121679387, 356.9678728914398, 357.4227622389841, 361.9149499867531, 363.93085313790397, 15131.92434037831, 15650.217489125527, 18878.0, 19431.805681943177, 19859.50351241218, 12298.877011229884, 15584.766228506553, 18464.907675461604, 18877.96171210586, 19030.714539281922, 5458.426865179159, 5631.014572449805, 5795.739191736382, 5798.478136967672, 5804.709764511778, 4127.153933443652, 5524.640898341595, 5672.376038635747, 5678.545716342683, 6123.387661233885, 6320.873582528347, 6335.176427064475, 6337.619742815423, 6341.968290158543, 6342.682865856712, 5495.395506494282, 5734.856628584319, 5742.2247996520355, 6304.211973503312, 6308.684565771716, 5395.649282796606, 5469.288992430998, 5483.177523371526, 5484.2596249506605, 5486.451354864522, 12439.875601243963, 12797.552085677049, 12821.615351539469, 12836.743265134739, 12867.42096605655, 1955.227685064406, 2031.7968203179712, 2155.5796619659172, 2663.3341664583854, 2738.3564862257354, 9342.346035777498, 9430.962594114642, 9592.856107158399, 9913.008699130101, 9969.651062212788, 1739.5216315513335, 1739.5651087228193, 1755.6839768841603, 1764.7970483394445, 1796.5239211608935, 84301.57849210776, 100309.0, 100907.99999999927, 103394.48302758513, 103951.0, 10943.945280273547, 11034.724131896766, 11207.775844483065, 11513.769724605461, 11587.130965177645, 13167.67080822987, 13202.537911173255, 13301.600951971457, 13302.0, 13316.201027938161, 8173.0, 8308.875366869503, 8315.251627353568, 8474.237318641352, 8513.95743021281, 8352.039515455679, 8543.871841922377, 8612.8708069379, 8664.0, 8763.69327073562, 4382.627476664456, 4462.219111655448, 4470.329450582439, 4495.483019452739, 4495.910081798411, 1853.935112271064, 1902.6670332691724, 1913.3781521005728, 1943.475261679367, 1946.3285166617495, 927.7819712367589, 934.8083642853198, 940.4545363689044, 1003.5935446144323, 1065.8880817514205, 18927.81072189288, 19117.330893418664, 19143.712844307345, 19839.20643174257, 20107.39677809668, 945.8817647794026, 947.8957314695378, 957.7461972577272, 1003.6035765872585, 1018.4602160854758, 10110.494475276208, 10428.895711042944, 10539.26225164231, 10938.289011214245, 11140.33158010522, 469638.0, 474498.0, 515045.0, 520337.0, 520515.3845384645, 126222.73777262293, 130602.34698826446, 130724.3463782675, 133768.3311583436, 133982.3300883509, 920.7974245665943, 956.2971216156259, 1068.5992752717732, 1100.0, 1100.9339439633648, 15506.612334691723, 17632.0, 17868.55328616795, 18067.638647227246, 18194.45416637503, 43291.0, 51808.481915181874, 52107.47892521178, 52215.73892130515, 52915.47084529259, 65096.02355964759, 76224.0, 77852.61073694595, 81647.59176204081, 85255.0, 7777.338926191111, 8013.799655008438, 8091.109977902308, 8199.754007379788, 8282.751517454486, 10959.12327013821, 13292.534761283308, 13333.533326333532, 13490.123141995738, 13631.795523066963, 10160.74598135023, 10317.019883111092, 10975.46343511893, 11542.19204655666, 11808.409579520818, 11521.423928803693, 11525.250858694159, 11556.191066625255, 11680.0, 11683.707907302045, 11558.537658493566, 11620.941895290469, 11745.706357341134, 11812.291262523931, 11827.526898923947, 7932.881006785018, 7993.0, 8057.0, 8086.474379165335, 8113.918860811316, 9191.218746406363, 11676.532938682358, 11702.88297117052, 11743.647690569296, 11788.174827761974], "unit": "score", "name": "jquery.html", "value": 9138.179852884168}, {"lowerIsBetter": false, "replicates": [1394.6304229379223, 1489.7467430536808, 1518.1194906953965, 1533.8696210822077, 1889.0743535667527, 7816.0, 8376.62305196266, 8574.485530868153, 8579.95710021449, 8579.957100214506, 8287.875681864776, 8542.530160841152, 8554.144585541442, 8557.443766155211, 8557.743267701964, 2127.702121702963, 2362.7755363240462, 2386.4153282445827, 2421.092090466075, 2436.0986435019067, 2444.168982545934, 2450.4486490539666, 2451.3626457121186, 2455.6439316299125, 2460.938476538092, 1983.7817840037585, 2407.38611654028, 2408.915687950922, 2414.7585241475886, 2416.4925365673143, 2346.4133966508375, 2385.5586716457424, 2399.0, 2402.3633737059695, 2404.2426635609813, 2352.0826877517784, 2372.632242002492, 2385.260569223529, 2398.568257713611, 2398.6282126270457, 8594.828103437958, 8688.13118688126, 8695.956520217422, 8700.129987001312, 8703.347248956354, 4863.343448634424, 5088.363954505687, 5205.349331333583, 5366.034113859504, 5404.729763511808, 3587.443946188345, 3619.4208926571887, 3669.669729724311, 3694.1503454205413, 3708.369577171887, 1030.7835354575473, 1047.675220681591, 1053.778706471642, 1081.1350919264557, 1081.9451035240577, 11531.904469075509, 11700.771419001052, 11721.882781172164, 11727.824082638766, 11730.882691173065, 4791.161546729309, 4802.542757078047, 4853.708777473363, 4854.538818812207, 4870.732109733999, 10008.599656013677, 10032.347897386646, 10036.498175091216, 10043.096121348968, 10047.59809607622, 4754.809807607726, 5362.91955620666, 5377.139657654835, 5401.432849550819, 5408.594355423359, 4407.471103467605, 4721.220998535272, 4877.097736918681, 4883.536064073907, 4892.461829198785, 3864.5362556492837, 3886.941695874564, 3894.8636797711943, 3924.038610540436, 3963.722539422213, 1244.954238439715, 1260.8171815086762, 1260.8865202131851, 1262.4003598290922, 1279.9168054076456, 1286.5754301080622, 1286.9292188929512, 1299.857015728269, 1300.655326338521, 1356.7015256643522, 8022.398320125897, 8074.717384891501, 8076.071251806, 8077.313428358655, 8110.31062359706, 498.25759618168667, 504.14547342254525, 504.81321910893206, 509.61524049342506, 511.15148852904, 6131.908021379683, 6203.596766210272, 6204.255489341218, 6207.131001659771, 6217.937820621826, 10095.495225238708, 10298.845517317246, 10343.896561034293, 10383.117435017957, 10460.581576736997, 9973.501324933724, 10161.796764064677, 10262.692119236435, 10312.071913527818, 10332.915043920431, 8062.234087761653, 8096.149904260085, 8123.512589244546, 8142.307903828241, 8219.506829590244, 6682.398584127452, 7917.366610671248, 7926.0, 8028.43800933929, 8112.22933821286, 9330.436302789694, 9474.099960503741, 9564.521773911416, 9595.28035397362, 9686.9031309686, 9669.419834809934, 10026.147777438999, 10036.498175091363, 10142.0, 10191.7452063699, 6676.532642715158, 6849.486288528281, 7458.776236712907, 7587.051618547682, 7786.532808031537, 8147.226013528705, 8178.918210818054, 8226.136255693305, 8226.547539885363, 8231.135730748185, 6267.310595834363, 7100.899360599115, 7106.502544821813, 7201.387882030086, 7388.187299396955, 6321.0, 6872.759453419107, 7065.364117229474, 7223.9886415902865, 7241.203467618452, 7543.547387156788, 7551.584662843597, 7610.467267291237, 7633.084029916446, 7665.348445382205, 6887.242403335529, 6948.131483564554, 6961.408280296231, 6984.3364880336285, 6992.405645520188, 6915.412189963708, 7035.366816986496, 7073.71705131789, 7084.326988936043, 7095.9645201773665], "unit": "score", "name": "mootools.html", "value": 4752.49230894254}, {"lowerIsBetter": false, "replicates": [310.492345015899, 318.4331889237159, 322.40677154036575, 324.634785865901, 326.476984865602, 6422.229332480103, 6511.674416279185, 6571.080048793173, 6586.07794908712, 6602.10871532343, 5252.185911183773, 6407.006913928349, 6462.192225971754, 6470.223573171214, 6497.967510162454, 4615.630749540045, 4693.131770622429, 4714.269288260325, 4841.007593443335, 4863.732494712789, 4776.570108690217, 4811.422629284473, 4820.662553621248, 4828.61371090312, 4829.444613869415, 4756.833510827122, 4759.167145749498, 4819.662623616348, 4825.927611085836, 4841.612670986313, 4553.521880202581, 4655.534446555352, 4770.0, 4780.976095119502, 4809.110314591811, 4093.4678491795876, 4095.508538975342, 4112.157007813421, 4116.567760385176, 4118.979405102956, 5475.589330800206, 5650.7174641267775, 6092.603980741238, 6096.177016102858, 6144.754209831602, 5592.748326325325, 5592.86017849553, 5601.131824567158, 5602.299712535933, 5605.943940560583, 6859.862802743967, 6860.245373009015, 6863.931360686429, 6875.862482750367, 6887.621180835052, 4253.51084625269, 4434.667399945017, 4444.622207112399, 4474.485434175046, 4574.451065872084, 7274.599897005663, 7283.526570772883, 7292.817679558, 7305.232950540223, 7306.196318405025, 3790.086006566666, 4555.883808466947, 4568.383268258743, 4577.542245775462, 4579.381783459257, 4629.67592268538, 4630.467496237909, 4633.62930965522, 4635.629149668019, 4650.116477869194, 5470.632341914521, 5478.808241711521, 5480.534154596824, 5483.369412517532, 5486.670799752028, 6663.100481435041, 6948.722051117999, 6963.7562685305775, 6988.336108069725, 7000.649967501605, 1576.7398379267522, 1598.7282162032482, 1608.0, 1608.549606110291, 1609.4688752711577, 952.1525842000625, 970.4613939263777, 1015.2334987084704, 1017.1455976979373, 1042.0309112525424, 6438.066480360321, 6553.639549824806, 6577.967110164419, 6579.0, 6583.670816459158, 7237.819054523679, 7239.420846332281, 7243.9637801811705, 7247.13034435871, 7251.274872512707, 6548.639824809586, 6550.7707230246715, 6564.606123632598, 6566.4418524425, 6572.441342485847, 3774.245150969817, 3813.9427908581392, 3815.294170578452, 3817.026658202141, 3817.7900215488417, 7368.968344431783, 7694.499857509356, 7695.730649427355, 7707.807304817312, 7715.22549813546, 7451.105867295959, 7496.737614183587, 7497.512661676974, 7497.625118744041, 7507.699692012258, 7655.196204398458, 7658.2724641159, 7659.004329437137, 7662.080550333995, 7662.348700360309, 6940.340667636567, 7212.278772122746, 7217.4586905983315, 7259.12890453149, 7261.310175533527, 7024.08686870724, 7083.256258093033, 7098.6450677466955, 7099.2190859006505, 7101.964490177723, 6957.243088732231, 7618.961905190438, 7639.923600763921, 7640.465167438449, 7643.082830060428, 4104.548499665094, 4578.084383123322, 4578.725276483422, 4580.381648477412, 4591.47198072226, 6881.380675739208, 7172.605506697182, 7194.820129496805, 7202.171750248579, 7207.27927207296, 6885.449164066963, 6937.583744975318, 6951.443884489127, 6963.721451141898, 6964.0, 6939.653017349214, 6963.199232088375, 6963.442924566124, 6969.686364113526, 6970.302969702989, 5867.295924489089, 6770.86458270822, 6812.863742725217, 6815.897761533482, 6821.0, 6553.737850485927, 6892.758753443605, 6914.585124892523, 6933.618650974245, 6942.826429339307, 5753.626014309057, 6489.772857949949, 6540.724558711196, 6636.568623039487, 6836.0], "unit": "score", "name": "prototype.html", "value": 5061.261266651872}, {"lowerIsBetter": false, "replicates": [632.2949910849404, 678.1455366238539, 737.6680493777798, 752.0, 784.9018872640917, 14628.414863405464, 14973.401063957443, 14986.950913436063, 14989.550313490585, 15010.399584016626, 15305.693886122272, 15735.527934161964, 15746.606334841636, 15749.921250393762, 15770.684586308267, 700.7652436433775, 708.890122031086, 835.4945258118842, 868.7654333329997, 873.9694110706126, 850.9446885952393, 862.1163307609719, 862.2412277196058, 865.7143142762873, 866.7096522664915, 909.295296145486, 911.389369122686, 912.4981260306838, 913.1644545241096, 913.4336711239008, 725.7205975699368, 733.9302766237199, 734.0384096833166, 905.1355955062932, 907.1925985872579, 660.2308310817939, 668.8394785251553, 668.906353110565, 670.0, 670.5105273150627, 15027.323770430357, 15088.698226035527, 15116.470923517734, 15124.168170750605, 15135.0, 12285.938570307091, 12385.814212786816, 12398.62804115878, 12586.370681465982, 12694.746105077847, 10079.630869985845, 10108.303249097484, 10123.392596444164, 10145.239107066925, 10170.23723220754, 3449.379111759882, 3505.3515099706383, 3506.211102501942, 3517.4547945068557, 3518.0501264658656, 84884.15115848824, 85565.57217213874, 86482.56758716165, 87178.0, 87366.0, 9005.954970225239, 9040.683576074805, 9147.81704365909, 9208.770637085929, 9270.44377337362, 17999.01005444687, 20125.698114528295, 20827.687584686242, 20897.79102208989, 20901.059452324684, 7387.889181662279, 7393.371563417169, 7461.477696561188, 7582.0, 7675.501092429086, 4077.7757223353, 4148.191102734938, 4156.480439945007, 4206.600372964564, 4357.106793107406, 3453.1712389026957, 3502.6847583717586, 3505.2638945821664, 3512.5258090158013, 3515.8945231643092, 612.3539665652779, 633.8605506788499, 637.3021541412146, 643.787550108463, 646.7348387161242, 507.0821812519352, 561.1134407635925, 598.5989387110646, 630.3412933484519, 638.4892086330917, 8424.326053915673, 8470.618822153017, 8485.914261591517, 8696.17386348296, 8935.195832375117, 575.4456737756951, 599.6372194822158, 601.3835818286292, 603.9396060393925, 624.341319907502, 3850.5956874528333, 3911.0, 4013.6931930938563, 4050.9392359114636, 4097.569755175723, 92956.0, 94113.0, 94454.52772736229, 94720.52639736758, 95016.52491737498, 56868.0, 78666.0, 81319.59340203379, 82478.58760706279, 82564.76152857712, 66261.66869165623, 70155.0, 72021.0, 72320.2767972324, 75494.62252688811, 7192.091691687764, 8746.344024198337, 8854.203121719076, 8874.0, 8930.240929520804, 47646.0, 48864.2670359952, 48876.77808054827, 49947.251846186664, 50409.74795126001, 62903.05645415414, 66338.0, 68411.0, 68836.6558167226, 70723.0, 11116.722081948015, 11122.165837562054, 11441.48513316886, 11450.885491145315, 11801.468933898166, 11950.760984780081, 12344.728646908756, 12354.011679065832, 12390.50311135955, 12540.24758514492, 8372.874406884024, 11084.501197445972, 11276.227256439939, 11815.881841181823, 12267.0, 11768.798075967468, 11770.94114529456, 11898.881011190124, 11965.700857478632, 12325.876741232833, 11255.021025155842, 11269.943650282024, 11387.829182562102, 11471.082313415074, 12308.569200077955, 9366.250699943852, 9529.475878826732, 9721.951390243003, 9731.0, 9842.60629574809, 7673.0, 9684.32209745311, 9770.511474426392, 9913.752156196153, 9998.800023999625], "unit": "score", "name": "yui.html", "value": 6878.491917075425}], "name": "dromaeo_css", "value": 7391.7016845876}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 112.0, 112.0, 111.0, 112.0, 116.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [157.0, 120.0, 146.0, 158.0, 118.0, 146.0, 137.0, 118.0, 176.0, 152.0], "unit": "score", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [186.0, 188.0, 184.0, 187.0, 187.0, 185.0, 187.0, 181.0, 182.0, 184.0], "unit": "score", "name": "audio-dft", "value": 185.1}, {"lowerIsBetter": true, "replicates": [73.0, 104.0, 118.0, 77.0, 75.0, 81.0, 89.0, 109.0, 76.0, 57.0], "unit": "score", "name": "audio-fft", "value": 85.9}, {"lowerIsBetter": true, "replicates": [95.0, 93.0, 121.0, 79.0, 104.0, 121.0, 148.0, 76.0, 79.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [88.0, 95.0, 89.0, 94.0, 87.0, 93.0, 87.0, 94.0, 87.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.7}, {"lowerIsBetter": true, "replicates": [104.0, 149.0, 121.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 104.0], "unit": "score", "name": "imaging-darkroom", "value": 105.5}, {"lowerIsBetter": true, "replicates": [127.0, 142.0, 88.0, 85.0, 85.0, 88.0, 85.0, 85.0, 85.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 54.0, 53.0, 53.0, 55.0, 66.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [64.0, 71.0, 75.0, 71.0, 71.0, 67.0, 68.0, 69.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 95.0, 107.0, 75.0, 98.0, 96.0, 107.0, 110.0, 108.0], "unit": "score", "name": "stanford-crypto-aes", "value": 96.1}, {"lowerIsBetter": true, "replicates": [123.0, 145.0, 143.0, 126.0, 121.0, 124.0, 124.0, 124.0, 127.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.9}, {"lowerIsBetter": true, "replicates": [141.0, 127.0, 138.0, 137.0, 136.0, 143.0, 135.0, 130.0, 138.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.4}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 68.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1473.9}]} 10:33:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1473.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7391.70"}}} 10:33:14 INFO - Return code: 0 10:33:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:33:14 INFO - # TBPL SUCCESS # 10:33:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:33:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:33:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:33:14 INFO - 2016-02-23 10:33:14.647 screenresolution[1969:13809] starting screenresolution argv=screenresolution get 10:33:14 INFO - 2016-02-23 10:33:14.650 screenresolution[1969:13809] Display 0: 1600x1200x32@60 10:33:14 INFO - 2016-02-23 10:33:14.656 screenresolution[1970:13812] starting screenresolution argv=screenresolution list 10:33:14 INFO - Available Modes on Display 0 10:33:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:33:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:33:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:33:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:33:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:33:14 INFO - Intel Iris: 10:33:14 INFO - Chipset Model: Intel Iris 10:33:14 INFO - Type: GPU 10:33:14 INFO - Bus: Built-In 10:33:14 INFO - VRAM (Dynamic, Max): 1536 MB 10:33:14 INFO - Vendor: Intel (0x8086) 10:33:14 INFO - Device ID: 0x0a2e 10:33:14 INFO - Revision ID: 0x0009 10:33:14 INFO - Displays: 10:33:14 INFO - Display: 10:33:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:33:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:33:14 INFO - Display Serial Number: 1600x1200 60 10:33:14 INFO - Main Display: Yes 10:33:14 INFO - Mirror: Off 10:33:14 INFO - Online: Yes 10:33:14 INFO - Rotation: Supported 10:33:14 INFO - Return code: 0 10:33:14 INFO - Running post-action listener: _resource_record_post_action 10:33:14 INFO - Running post-run listener: _resource_record_post_run 10:33:15 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 2564096; Write bytes: 707289088; Read time: 40; Write time: 1916 10:33:15 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 404670976; Write bytes: 405956096; Read time: 31270; Write time: 700 10:33:15 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 2564096; Write bytes: 298468352; Read time: 40; Write time: 1117 10:33:15 INFO - Running post-run listener: _upload_blobber_files 10:33:15 INFO - Blob upload gear active. 10:33:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:33:15 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 10:33:15 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'] 10:33:15 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 10:33:16 INFO - (blobuploader) - INFO - Open directory for files ... 10:33:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:33:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:33:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:17 INFO - (blobuploader) - INFO - Done attempting. 10:33:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:33:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:33:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:18 INFO - (blobuploader) - INFO - Done attempting. 10:33:18 INFO - (blobuploader) - INFO - Iteration through files over. 10:33:18 INFO - Return code: 0 10:33:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:33:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:33:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d12f951782ad86824c0d7e36a9743f04fe7560176ea61abaf18b0e80d23d5a186c00521d8f068d1870970464df444f079059e3d99162753809e73968daf82d82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/741c0a3568524506ab38704ef32874e10ce964f6e15d7ceee287c902a398c576cc74aafc05630df764ea3b6542df4e3f2593c8eaedff2120528cd146e78d460a"} 10:33:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:33:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:33:18 INFO - Contents: 10:33:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d12f951782ad86824c0d7e36a9743f04fe7560176ea61abaf18b0e80d23d5a186c00521d8f068d1870970464df444f079059e3d99162753809e73968daf82d82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/741c0a3568524506ab38704ef32874e10ce964f6e15d7ceee287c902a398c576cc74aafc05630df764ea3b6542df4e3f2593c8eaedff2120528cd146e78d460a"} 10:33:18 INFO - Running post-run listener: copy_logs_to_upload_dir 10:33:18 INFO - Copying logs to upload dir... 10:33:18 INFO - mkdir: /builds/slave/test/build/upload/logs 10:33:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.558507 ========= master_lag: 35.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 36 secs) (at 2016-02-23 10:33:53.647991) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-23 10:33:53.651364) ========= 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.CIc27o8R65/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.IelLpnwqDY/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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/d12f951782ad86824c0d7e36a9743f04fe7560176ea61abaf18b0e80d23d5a186c00521d8f068d1870970464df444f079059e3d99162753809e73968daf82d82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/741c0a3568524506ab38704ef32874e10ce964f6e15d7ceee287c902a398c576cc74aafc05630df764ea3b6542df4e3f2593c8eaedff2120528cd146e78d460a"} build_url:https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/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/d12f951782ad86824c0d7e36a9743f04fe7560176ea61abaf18b0e80d23d5a186c00521d8f068d1870970464df444f079059e3d99162753809e73968daf82d82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/741c0a3568524506ab38704ef32874e10ce964f6e15d7ceee287c902a398c576cc74aafc05630df764ea3b6542df4e3f2593c8eaedff2120528cd146e78d460a"}' ========= master_lag: 1.53 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-23 10:33:55.190062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:33:55.190350) ========= 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.CIc27o8R65/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.IelLpnwqDY/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.005437 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:33:55.259338) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 10:33:55.259727) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 10:33:55.279830) ========= ========= Total master_lag: 40.35 =========