builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0067 starttime: 1454982316.74 results: success (0) buildid: 20160208164823 builduid: 30a40c8c361641e58b7426d55eb90c1e revision: 49945e5fe79e6cf2b083f56fd49d917ca886db0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:16.743192) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:16.743701) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:16.744032) ========= 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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005504 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:16.767191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:16.767517) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:16.784140) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:16.784444) ========= 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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005780 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:16.833233) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:16.833570) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:16.834052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-08 17:45:16.834437) ========= 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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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-08 17:45:16-- 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% 44.7M=0s 2016-02-08 17:45:17 (44.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.205721 ========= master_lag: 2.45 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-08 17:45:19.494304) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:19.494722) ========= 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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.027081 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:19.544951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-08 17:45:19.548392) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 49945e5fe79e6cf2b083f56fd49d917ca886db0b --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 49945e5fe79e6cf2b083f56fd49d917ca886db0b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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-08 17:45:19,626 truncating revision to first 12 chars 2016-02-08 17:45:19,626 Setting DEBUG logging. 2016-02-08 17:45:19,626 attempt 1/10 2016-02-08 17:45:19,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/49945e5fe79e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-08 17:45:21,296 unpacking tar archive at: fx-team-49945e5fe79e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.918994 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-08 17:45:21.584110) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:21.584514) ========= echo 49945e5fe79e6cf2b083f56fd49d917ca886db0b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'49945e5fe79e6cf2b083f56fd49d917ca886db0b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 49945e5fe79e6cf2b083f56fd49d917ca886db0b program finished with exit code 0 elapsedTime=0.006386 script_repo_revision: '49945e5fe79e6cf2b083f56fd49d917ca886db0b' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:21.613865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:21.614547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 17:45:21.631020) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-02-08 17:45:21.631348) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 17:45:21 INFO - MultiFileLogger online at 20160208 17:45:21 in /builds/slave/test 17:45:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:45:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:45:21 INFO - {'append_to_log': False, 17:45:21 INFO - 'base_work_dir': '/builds/slave/test', 17:45:21 INFO - 'blob_upload_branch': 'Fx-Team', 17:45:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:45:21 INFO - 'branch': 'Fx-Team', 17:45:21 INFO - 'buildbot_json_path': 'buildprops.json', 17:45:21 INFO - 'config_files': ('talos/mac_config.py',), 17:45:21 INFO - 'default_actions': ('clobber', 17:45:21 INFO - 'read-buildbot-config', 17:45:21 INFO - 'download-and-extract', 17:45:21 INFO - 'populate-webroot', 17:45:21 INFO - 'create-virtualenv', 17:45:21 INFO - 'install', 17:45:21 INFO - 'run-tests'), 17:45:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:45:21 INFO - 'download_minidump_stackwalk': True, 17:45:21 INFO - 'download_symbols': 'ondemand', 17:45:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:45:21 INFO - 'tooltool.py': '/tools/tooltool.py', 17:45:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:45:21 INFO - '/tools/misc-python/virtualenv.py')}, 17:45:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:45:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:45:21 INFO - 'installer_path': 'installer.exe', 17:45:21 INFO - 'log_level': 'info', 17:45:21 INFO - 'log_name': 'talos', 17:45:21 INFO - 'log_to_console': True, 17:45:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:45:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:45:21 INFO - 'opt_config_files': (), 17:45:21 INFO - 'pip_index': False, 17:45:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:45:21 INFO - 'cmd': ('bash', 17:45:21 INFO - '-c', 17:45:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:45:21 INFO - 'enabled': True, 17:45:21 INFO - 'halt_on_failure': False, 17:45:21 INFO - 'name': 'check_screen_resolution'},), 17:45:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:45:21 INFO - 'cmd': ('bash', 17:45:21 INFO - '-c', 17:45:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:45:21 INFO - 'enabled': True, 17:45:21 INFO - 'halt_on_failure': False, 17:45:21 INFO - 'name': 'check_screen_resolution'},), 17:45:21 INFO - 'run_cmd_checks_enabled': True, 17:45:21 INFO - 'sps_profile': False, 17:45:21 INFO - 'sps_profile_interval': 0, 17:45:21 INFO - 'suite': 'dromaeojs-e10s', 17:45:21 INFO - 'system_bits': '32', 17:45:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:45:21 INFO - 'title': 't-yosemite-r7-0067', 17:45:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:45:21 INFO - 'use_talos_json': True, 17:45:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:45:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:45:21 INFO - 'work_dir': 'build'} 17:45:21 INFO - ##### 17:45:21 INFO - ##### Running clobber step. 17:45:21 INFO - ##### 17:45:21 INFO - Running pre-action listener: _resource_record_pre_action 17:45:21 INFO - Running main action method: clobber 17:45:21 INFO - rmtree: /builds/slave/test/build 17:45:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:45:23 INFO - Running post-action listener: _resource_record_post_action 17:45:23 INFO - ##### 17:45:23 INFO - ##### Running read-buildbot-config step. 17:45:23 INFO - ##### 17:45:23 INFO - Running pre-action listener: _resource_record_pre_action 17:45:23 INFO - Running main action method: read_buildbot_config 17:45:23 INFO - Using buildbot properties: 17:45:23 INFO - { 17:45:23 INFO - "project": "", 17:45:23 INFO - "product": "firefox", 17:45:23 INFO - "script_repo_revision": "production", 17:45:23 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:45:23 INFO - "repository": "", 17:45:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:45:23 INFO - "buildid": "20160208164823", 17:45:23 INFO - "pgo_build": "False", 17:45:23 INFO - "basedir": "/builds/slave/test", 17:45:23 INFO - "buildnumber": 406, 17:45:23 INFO - "slavename": "t-yosemite-r7-0067", 17:45:23 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:45:23 INFO - "platform": "yosemite_r7", 17:45:23 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:45:23 INFO - "branch": "fx-team", 17:45:23 INFO - "repo_path": "integration/fx-team", 17:45:23 INFO - "revision": "49945e5fe79e6cf2b083f56fd49d917ca886db0b", 17:45:23 INFO - "stage_platform": "macosx64", 17:45:23 INFO - "builduid": "30a40c8c361641e58b7426d55eb90c1e", 17:45:23 INFO - "slavebuilddir": "test" 17:45:23 INFO - } 17:45:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 17:45:23 INFO - Running post-action listener: _resource_record_post_action 17:45:23 INFO - ##### 17:45:23 INFO - ##### Running download-and-extract step. 17:45:23 INFO - ##### 17:45:23 INFO - Running pre-action listener: _resource_record_pre_action 17:45:23 INFO - Running main action method: download_and_extract 17:45:23 INFO - mkdir: /builds/slave/test/build/tests 17:45: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')]} 17:45:23 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:45:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 17:45:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 17:45:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:45:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:45:25 INFO - Downloaded 1277 bytes. 17:45:25 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:45:25 INFO - Using the following test package requirements: 17:45:25 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:45:25 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:45:25 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 17:45:25 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:45:25 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 17:45:25 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:45:25 INFO - u'jsshell-mac.zip'], 17:45:25 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:45:25 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 17:45:25 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:45:25 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:45:25 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 17:45:25 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:45:25 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 17:45:25 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:45:25 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 17:45:25 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:45:25 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:45:25 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 17:45:25 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:45:25 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')]} 17:45:25 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:45:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:45:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:45:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 17:45:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 17:45:26 INFO - Downloaded 17753849 bytes. 17:45:26 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'] 17:45:26 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 17:45:29 INFO - Return code: 0 17:45:29 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 17:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:29 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:45:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:45:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:45:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 17:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 17:45:30 INFO - Downloaded 17753849 bytes. 17:45:30 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'] 17:45:30 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 17:45:33 INFO - Return code: 0 17:45:33 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')]} 17:45:33 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:45:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:45:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:45:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 17:45:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 17:45:34 INFO - Downloaded 10706547 bytes. 17:45:34 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'] 17:45:34 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 17:45:34 INFO - Return code: 0 17:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:34 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:45:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:45:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:45:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 17:45:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 17:45:37 INFO - Downloaded 111836573 bytes. 17:45:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:45:37 INFO - mkdir: /builds/slave/test/properties 17:45:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:45:37 INFO - Writing to file /builds/slave/test/properties/build_url 17:45:37 INFO - Contents: 17:45:37 INFO - build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:45:38 INFO - Running post-action listener: _resource_record_post_action 17:45:38 INFO - Running post-action listener: set_extra_try_arguments 17:45:38 INFO - ##### 17:45:38 INFO - ##### Running populate-webroot step. 17:45:38 INFO - ##### 17:45:38 INFO - Running pre-action listener: _resource_record_pre_action 17:45:38 INFO - Running main action method: populate_webroot 17:45:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:45:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:45:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:45:38 INFO - '--tppagecycles', 17:45:38 INFO - '7'], 17:45:38 INFO - 'tests': ['tsvgm']}}, 17:45:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:45:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:45:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:45:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:45:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:45:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:45:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:45:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:38 INFO - 'talos_options': ['--e10s'], 17:45:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:45:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:38 INFO - 'tests': ['damp', 'tps']}, 17:45:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:38 INFO - 'talos_options': ['--e10s'], 17:45:38 INFO - 'tests': ['damp', 'tps']}, 17:45:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:45:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:45:38 INFO - 'other': {'tests': ['a11yr', 17:45:38 INFO - 'ts_paint', 17:45:38 INFO - 'tpaint', 17:45:38 INFO - 'sessionrestore', 17:45:38 INFO - 'sessionrestore_no_auto_restore']}, 17:45:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:45:38 INFO - 'tests': ['a11yr', 17:45:38 INFO - 'ts_paint', 17:45:38 INFO - 'tpaint', 17:45:38 INFO - 'sessionrestore', 17:45:38 INFO - 'sessionrestore_no_auto_restore']}, 17:45:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:45:38 INFO - 'tests': ['a11yr', 17:45:38 INFO - 'ts_paint', 17:45:38 INFO - 'tpaint', 17:45:38 INFO - 'sessionrestore', 17:45:38 INFO - 'sessionrestore_no_auto_restore']}, 17:45:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:45:38 INFO - 'tests': ['a11yr', 17:45:38 INFO - 'ts_paint', 17:45:38 INFO - 'tpaint', 17:45:38 INFO - 'sessionrestore', 17:45:38 INFO - 'sessionrestore_no_auto_restore']}, 17:45:38 INFO - 'other_l64': {'tests': ['a11yr', 17:45:38 INFO - 'ts_paint', 17:45:38 INFO - 'tpaint', 17:45:38 INFO - 'sessionrestore', 17:45:38 INFO - 'sessionrestore_no_auto_restore']}, 17:45:38 INFO - 'other_nol64': {'tests': ['a11yr', 17:45:38 INFO - 'ts_paint', 17:45:38 INFO - 'tpaint', 17:45:38 INFO - 'sessionrestore', 17:45:38 INFO - 'sessionrestore_no_auto_restore']}, 17:45:38 INFO - 'svgr': {'tests': ['tsvgx', 17:45:38 INFO - 'tsvgr_opacity', 17:45:38 INFO - 'tart', 17:45:38 INFO - 'tscrollx', 17:45:38 INFO - 'cart']}, 17:45:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:45:38 INFO - 'tests': ['tsvgx', 17:45:38 INFO - 'tsvgr_opacity', 17:45:38 INFO - 'tart', 17:45:38 INFO - 'tscrollx', 17:45:38 INFO - 'cart']}, 17:45:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:38 INFO - 'tests': ['tp5o']}, 17:45:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:38 INFO - 'talos_options': ['--e10s'], 17:45:38 INFO - 'tests': ['tp5o']}, 17:45:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:38 INFO - 'talos_options': ['--xperf_path', 17:45:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:45:38 INFO - 'tests': ['tp5n']}, 17:45:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:38 INFO - 'talos_options': ['--e10s', 17:45:38 INFO - '--xperf_path', 17:45:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:45:39 INFO - 'tests': ['tp5n']}}, 17:45:39 INFO - 'talos.zip': {'path': '', 17:45:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:45:39 INFO - Running post-action listener: _resource_record_post_action 17:45:39 INFO - ##### 17:45:39 INFO - ##### Running create-virtualenv step. 17:45:39 INFO - ##### 17:45:39 INFO - Running pre-action listener: _resource_record_pre_action 17:45:39 INFO - Running main action method: create_virtualenv 17:45:39 INFO - Creating virtualenv /builds/slave/test/build/venv 17:45:39 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 17:45:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:45:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:45:39 INFO - Using real prefix '/tools/python27' 17:45:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:45:39 INFO - Installing distribute.............................................................................................................................................................................................done. 17:45:42 INFO - Installing pip.................done. 17:45:42 INFO - Return code: 0 17:45:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101646a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9090480f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ead30>, '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 0x10130edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e1b20>, '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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 17:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5z00Ma2NOn/Render', 17:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:45:42 INFO - 'HOME': '/Users/cltbld', 17:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:45:42 INFO - 'LOGNAME': 'cltbld', 17:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:42 INFO - 'MOZ_NO_REMOTE': '1', 17:45:42 INFO - 'NO_EM_RESTART': '1', 17:45:42 INFO - 'PAGER': '/bin/cat', 17:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:42 INFO - 'PWD': '/builds/slave/test', 17:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:45:42 INFO - 'SHELL': '/bin/bash', 17:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fPm8aPzOIJ/Listeners', 17:45:42 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 17:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:45:42 INFO - 'USER': 'cltbld', 17:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:42 INFO - 'XPC_FLAGS': '0x0', 17:45:42 INFO - 'XPC_SERVICE_NAME': '0', 17:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:42 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 17:45:42 INFO - Cleaning up... 17:45:42 INFO - Return code: 0 17:45:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101646a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9090480f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ead30>, '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 0x10130edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e1b20>, '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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 17:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5z00Ma2NOn/Render', 17:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:45:42 INFO - 'HOME': '/Users/cltbld', 17:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:45:42 INFO - 'LOGNAME': 'cltbld', 17:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:42 INFO - 'MOZ_NO_REMOTE': '1', 17:45:42 INFO - 'NO_EM_RESTART': '1', 17:45:42 INFO - 'PAGER': '/bin/cat', 17:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:42 INFO - 'PWD': '/builds/slave/test', 17:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:45:42 INFO - 'SHELL': '/bin/bash', 17:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fPm8aPzOIJ/Listeners', 17:45:42 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 17:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:45:42 INFO - 'USER': 'cltbld', 17:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:42 INFO - 'XPC_FLAGS': '0x0', 17:45:42 INFO - 'XPC_SERVICE_NAME': '0', 17:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:43 INFO - Downloading/unpacking psutil>=0.7.1 17:45: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 17:45: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 17:45: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 17:45: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 17:45: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 17:45: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 17:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:45:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:45:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:45:46 INFO - Installing collected packages: psutil 17:45:46 INFO - Running setup.py install for psutil 17:45:46 INFO - building 'psutil._psutil_osx' extension 17:45:46 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 17:45:46 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 17:45:46 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 17:45:46 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 17:45:46 INFO - building 'psutil._psutil_posix' extension 17:45:46 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 17:45:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:45:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:45:47 INFO - ^ 17:45:47 INFO - 1 warning generated. 17:45:47 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 17:45:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:45:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:45:47 INFO - Successfully installed psutil 17:45:47 INFO - Cleaning up... 17:45:47 INFO - Return code: 0 17:45:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:47 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 0x101646a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9090480f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ead30>, '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 0x10130edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e1b20>, '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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 17:45:47 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 17:45:47 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 17:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5z00Ma2NOn/Render', 17:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:45:47 INFO - 'HOME': '/Users/cltbld', 17:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:45:47 INFO - 'LOGNAME': 'cltbld', 17:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:47 INFO - 'MOZ_NO_REMOTE': '1', 17:45:47 INFO - 'NO_EM_RESTART': '1', 17:45:47 INFO - 'PAGER': '/bin/cat', 17:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:47 INFO - 'PWD': '/builds/slave/test', 17:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:45:47 INFO - 'SHELL': '/bin/bash', 17:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fPm8aPzOIJ/Listeners', 17:45:47 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 17:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:45:47 INFO - 'USER': 'cltbld', 17:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:47 INFO - 'XPC_FLAGS': '0x0', 17:45:47 INFO - 'XPC_SERVICE_NAME': '0', 17:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:45:49 INFO - Installing collected packages: mozsystemmonitor 17:45:49 INFO - Running setup.py install for mozsystemmonitor 17:45:50 INFO - Successfully installed mozsystemmonitor 17:45:50 INFO - Cleaning up... 17:45:50 INFO - Return code: 0 17:45:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:50 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 0x101646a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9090480f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ead30>, '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 0x10130edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e1b20>, '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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 17:45:50 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 17:45:50 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 17:45:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5z00Ma2NOn/Render', 17:45:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:45:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:45:50 INFO - 'HOME': '/Users/cltbld', 17:45:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:45:50 INFO - 'LOGNAME': 'cltbld', 17:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:50 INFO - 'MOZ_NO_REMOTE': '1', 17:45:50 INFO - 'NO_EM_RESTART': '1', 17:45:50 INFO - 'PAGER': '/bin/cat', 17:45:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:50 INFO - 'PWD': '/builds/slave/test', 17:45:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:45:50 INFO - 'SHELL': '/bin/bash', 17:45:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fPm8aPzOIJ/Listeners', 17:45:50 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 17:45:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:45:50 INFO - 'USER': 'cltbld', 17:45:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:45:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:50 INFO - 'XPC_FLAGS': '0x0', 17:45:50 INFO - 'XPC_SERVICE_NAME': '0', 17:45:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:50 INFO - Downloading/unpacking blobuploader==1.2.4 17:45:50 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 17:45:50 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 17:45:50 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 17:45:50 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 17:45:50 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 17:45:50 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 17:45:52 INFO - Downloading blobuploader-1.2.4.tar.gz 17:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:45:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:45:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:53 INFO - Downloading docopt-0.6.1.tar.gz 17:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:45:53 INFO - Installing collected packages: blobuploader, requests, docopt 17:45:53 INFO - Running setup.py install for blobuploader 17:45:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:45:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:45:54 INFO - Running setup.py install for requests 17:45:54 INFO - Running setup.py install for docopt 17:45:54 INFO - Successfully installed blobuploader requests docopt 17:45:54 INFO - Cleaning up... 17:45:54 INFO - Return code: 0 17:45:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:54 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 0x101646a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9090480f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ead30>, '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 0x10130edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e1b20>, '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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 17:45:54 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 17:45:54 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 17:45:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5z00Ma2NOn/Render', 17:45:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:45:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:45:54 INFO - 'HOME': '/Users/cltbld', 17:45:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:45:54 INFO - 'LOGNAME': 'cltbld', 17:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:54 INFO - 'MOZ_NO_REMOTE': '1', 17:45:54 INFO - 'NO_EM_RESTART': '1', 17:45:54 INFO - 'PAGER': '/bin/cat', 17:45:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:54 INFO - 'PWD': '/builds/slave/test', 17:45:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:45:54 INFO - 'SHELL': '/bin/bash', 17:45:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fPm8aPzOIJ/Listeners', 17:45:54 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 17:45:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:45:54 INFO - 'USER': 'cltbld', 17:45:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:45:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:54 INFO - 'XPC_FLAGS': '0x0', 17:45:54 INFO - 'XPC_SERVICE_NAME': '0', 17:45:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:45:55 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-PI_b41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:45:55 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-LD_4WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:45:55 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-wxfQYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:45:55 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-OtBsh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:45:55 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-1BdcDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:45:55 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-vRkkXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:45:55 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-VCzFQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:45:55 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-vWfrST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:45:55 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-YaXkvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:45:55 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-fmcHKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:45:56 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-_FF3KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:45:56 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-jRFAb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:45:56 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-NiAol5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:45:56 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-4jb61W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:56 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-TxrYqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:45:56 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Hn5nQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:45:56 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Wjqus7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:45:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:45:56 INFO - Running setup.py install for manifestparser 17:45:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:45:56 INFO - Running setup.py install for mozcrash 17:45:57 INFO - Running setup.py install for mozdebug 17:45:57 INFO - Running setup.py install for mozdevice 17:45:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:45:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:45:57 INFO - Running setup.py install for mozfile 17:45:57 INFO - Running setup.py install for mozhttpd 17:45:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:45:57 INFO - Running setup.py install for mozinfo 17:45:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:45:57 INFO - Running setup.py install for mozInstall 17:45:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:45:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:45:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:45:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:45:57 INFO - Running setup.py install for mozleak 17:45:58 INFO - Running setup.py install for mozlog 17:45:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:45:58 INFO - Running setup.py install for moznetwork 17:45:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:45:58 INFO - Running setup.py install for mozprocess 17:45:58 INFO - Running setup.py install for mozprofile 17:45:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:45:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:45:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:45:58 INFO - Running setup.py install for mozrunner 17:45:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:45:58 INFO - Running setup.py install for mozscreenshot 17:45:59 INFO - Running setup.py install for moztest 17:45:59 INFO - Running setup.py install for mozversion 17:45:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:45:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:45:59 INFO - Cleaning up... 17:45:59 INFO - Return code: 0 17:45:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:59 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 0x101646a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9090480f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ead30>, '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 0x10130edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e1b20>, '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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 17:45:59 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 17:45:59 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 17:45:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5z00Ma2NOn/Render', 17:45:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:45:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:45:59 INFO - 'HOME': '/Users/cltbld', 17:45:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:45:59 INFO - 'LOGNAME': 'cltbld', 17:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:59 INFO - 'MOZ_NO_REMOTE': '1', 17:45:59 INFO - 'NO_EM_RESTART': '1', 17:45:59 INFO - 'PAGER': '/bin/cat', 17:45:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:59 INFO - 'PWD': '/builds/slave/test', 17:45:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:45:59 INFO - 'SHELL': '/bin/bash', 17:45:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fPm8aPzOIJ/Listeners', 17:45:59 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 17:45:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:45:59 INFO - 'USER': 'cltbld', 17:45:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:45:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:59 INFO - 'XPC_FLAGS': '0x0', 17:45:59 INFO - 'XPC_SERVICE_NAME': '0', 17:45:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:45:59 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-zMN_tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:45:59 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)) 17:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:45:59 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-BPkaBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:45:59 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)) 17:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:45:59 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-HdYrvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:45:59 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)) 17:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:45:59 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-zibUau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:46:00 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)) 17:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:46:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-qVdahL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:46:00 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)) 17:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:46:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-jnwVBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:46:00 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)) 17:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:46:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-UOYfod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:46:00 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)) 17:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:46:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-0UNe_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:46:00 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)) 17:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:46:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-kOCP9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:46:00 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)) 17:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:46:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Uk4elV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:46:00 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)) 17:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:46:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-An6pJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:46:00 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)) 17:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:46:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-EedGMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:46:00 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)) 17:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:46:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-3Xnb2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:46:00 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)) 17:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:46:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-zAnSHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:46:01 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)) 17:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-L68BOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:01 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)) 17:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:46:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Js2lGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:46:01 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)) 17:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:46:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-calwMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:46:01 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)) 17:46:01 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)) 17:46:01 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)) 17:46:01 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)) 17:46:01 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)) 17:46:01 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)) 17:46:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:46: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 17:46: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 17:46: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 17:46: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 17:46: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 17:46: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 17:46:03 INFO - Downloading blessings-1.6.tar.gz 17:46:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:46:03 INFO - Installing collected packages: blessings 17:46:03 INFO - Running setup.py install for blessings 17:46:03 INFO - Successfully installed blessings 17:46:03 INFO - Cleaning up... 17:46:04 INFO - Return code: 0 17:46:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:46:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:46:04 INFO - Reading from file tmpfile_stdout 17:46:04 INFO - Current package versions: 17:46:04 INFO - blessings == 1.6 17:46:04 INFO - blobuploader == 1.2.4 17:46:04 INFO - docopt == 0.6.1 17:46:04 INFO - manifestparser == 1.1 17:46:04 INFO - mozInstall == 1.12 17:46:04 INFO - mozcrash == 0.16 17:46:04 INFO - mozdebug == 0.1 17:46:04 INFO - mozdevice == 0.48 17:46:04 INFO - mozfile == 1.2 17:46:04 INFO - mozhttpd == 0.7 17:46:04 INFO - mozinfo == 0.9 17:46:04 INFO - mozleak == 0.1 17:46:04 INFO - mozlog == 3.1 17:46:04 INFO - moznetwork == 0.27 17:46:04 INFO - mozprocess == 0.22 17:46:04 INFO - mozprofile == 0.28 17:46:04 INFO - mozrunner == 6.11 17:46:04 INFO - mozscreenshot == 0.1 17:46:04 INFO - mozsystemmonitor == 0.0 17:46:04 INFO - moztest == 0.7 17:46:04 INFO - mozversion == 1.4 17:46:04 INFO - psutil == 3.1.1 17:46:04 INFO - requests == 1.2.3 17:46:04 INFO - wsgiref == 0.1.2 17:46:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:46:04 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')]} 17:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:04 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')]} 17:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:04 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 0x101646a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9090480f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ead30>, '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 0x10130edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e1b20>, '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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 17:46:04 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 17:46:04 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 17:46:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5z00Ma2NOn/Render', 17:46:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:04 INFO - 'HOME': '/Users/cltbld', 17:46:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:04 INFO - 'LOGNAME': 'cltbld', 17:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:04 INFO - 'MOZ_NO_REMOTE': '1', 17:46:04 INFO - 'NO_EM_RESTART': '1', 17:46:04 INFO - 'PAGER': '/bin/cat', 17:46:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:04 INFO - 'PWD': '/builds/slave/test', 17:46:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:04 INFO - 'SHELL': '/bin/bash', 17:46:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fPm8aPzOIJ/Listeners', 17:46:04 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 17:46:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:04 INFO - 'USER': 'cltbld', 17:46:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:04 INFO - 'XPC_FLAGS': '0x0', 17:46:04 INFO - 'XPC_SERVICE_NAME': '0', 17:46:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:04 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)) 17:46:04 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)) 17:46:04 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)) 17:46:04 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)) 17:46:04 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)) 17:46:04 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)) 17:46:04 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)) 17:46:04 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)) 17:46:04 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)) 17:46:04 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)) 17:46:04 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)) 17:46:04 INFO - Cleaning up... 17:46:04 INFO - Return code: 0 17:46:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:46:04 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')]} 17:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:04 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')]} 17:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:04 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 0x101646a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9090480f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ead30>, '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 0x10130edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e1b20>, '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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 17:46:04 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 17:46:04 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 17:46:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5z00Ma2NOn/Render', 17:46:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:04 INFO - 'HOME': '/Users/cltbld', 17:46:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:04 INFO - 'LOGNAME': 'cltbld', 17:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:04 INFO - 'MOZ_NO_REMOTE': '1', 17:46:04 INFO - 'NO_EM_RESTART': '1', 17:46:04 INFO - 'PAGER': '/bin/cat', 17:46:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:04 INFO - 'PWD': '/builds/slave/test', 17:46:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:04 INFO - 'SHELL': '/bin/bash', 17:46:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fPm8aPzOIJ/Listeners', 17:46:04 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 17:46:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:04 INFO - 'USER': 'cltbld', 17:46:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:04 INFO - 'XPC_FLAGS': '0x0', 17:46:04 INFO - 'XPC_SERVICE_NAME': '0', 17:46:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:04 INFO - Downloading/unpacking jsonschema 17:46: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 17:46: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 17:46: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 17:46: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 17:46: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 17:46: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 17:46:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:46:07 INFO - Downloading/unpacking functools32 (from jsonschema) 17:46:07 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 17:46:07 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 17:46:07 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 17:46:07 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 17:46:07 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 17:46:07 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 17:46:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:46:07 INFO - warning: no files found matching '*.txt' 17:46:07 INFO - no previously-included directories found matching 'build' 17:46:07 INFO - no previously-included directories found matching 'dist' 17:46:07 INFO - no previously-included directories found matching '.git*' 17:46:07 INFO - Installing collected packages: jsonschema, functools32 17:46:07 INFO - Running setup.py install for functools32 17:46:07 INFO - warning: no files found matching '*.txt' 17:46:07 INFO - no previously-included directories found matching 'build' 17:46:07 INFO - no previously-included directories found matching 'dist' 17:46:07 INFO - no previously-included directories found matching '.git*' 17:46:07 INFO - Successfully installed jsonschema functools32 17:46:07 INFO - Cleaning up... 17:46:07 INFO - Return code: 0 17:46:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:46:07 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')]} 17:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:07 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')]} 17:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:07 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 0x101646a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9090480f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ead30>, '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 0x10130edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e1b20>, '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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 17:46:07 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 17:46:07 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 17:46:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5z00Ma2NOn/Render', 17:46:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:07 INFO - 'HOME': '/Users/cltbld', 17:46:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:07 INFO - 'LOGNAME': 'cltbld', 17:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:07 INFO - 'MOZ_NO_REMOTE': '1', 17:46:07 INFO - 'NO_EM_RESTART': '1', 17:46:07 INFO - 'PAGER': '/bin/cat', 17:46:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:07 INFO - 'PWD': '/builds/slave/test', 17:46:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:07 INFO - 'SHELL': '/bin/bash', 17:46:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fPm8aPzOIJ/Listeners', 17:46:07 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 17:46:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:07 INFO - 'USER': 'cltbld', 17:46:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:07 INFO - 'XPC_FLAGS': '0x0', 17:46:07 INFO - 'XPC_SERVICE_NAME': '0', 17:46:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:08 INFO - Downloading/unpacking flake8 17:46:08 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 17:46:08 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 17:46:08 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 17:46:08 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 17:46:08 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 17:46:08 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 17:46:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:46:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:46:10 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 17:46:10 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 17:46:10 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 17:46:10 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 17:46:10 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 17:46:10 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 17:46:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:46:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:46:10 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 17:46:10 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 17:46:10 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 17:46:10 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 17:46:10 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 17:46:10 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 17:46:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:46:11 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 17:46:11 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 17:46:11 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 17:46:11 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 17:46:11 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 17:46:11 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 17:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:46:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:46:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:46:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:46:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:46:11 INFO - no previously-included directories found matching 'docs/_build' 17:46:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:46:11 INFO - Running setup.py install for pep8 17:46:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:46:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:46:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:46:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:46:11 INFO - no previously-included directories found matching 'docs/_build' 17:46:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:46:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:46:11 INFO - Cleaning up... 17:46:11 INFO - Return code: 0 17:46:11 INFO - Running post-action listener: _resource_record_post_action 17:46:11 INFO - Running post-action listener: _start_resource_monitoring 17:46:12 INFO - Starting resource monitoring. 17:46:12 INFO - ##### 17:46:12 INFO - ##### Running install step. 17:46:12 INFO - ##### 17:46:12 INFO - Running pre-action listener: _resource_record_pre_action 17:46:12 INFO - Running main action method: install 17:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:46:12 INFO - Reading from file tmpfile_stdout 17:46:12 INFO - Detecting whether we're running mozinstall >=1.0... 17:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:46:12 INFO - Reading from file tmpfile_stdout 17:46:12 INFO - Output received: 17:46:12 INFO - Usage: mozinstall [options] installer 17:46:12 INFO - Options: 17:46:12 INFO - -h, --help show this help message and exit 17:46:12 INFO - -d DEST, --destination=DEST 17:46:12 INFO - Directory to install application into. [default: 17:46:12 INFO - "/builds/slave/test"] 17:46:12 INFO - --app=APP Application being installed. [default: firefox] 17:46:12 INFO - mkdir: /builds/slave/test/build/application 17:46:12 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'] 17:46:12 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 17:46:46 INFO - Reading from file tmpfile_stdout 17:46:46 INFO - Output received: 17:46:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:46:46 INFO - Running post-action listener: _resource_record_post_action 17:46:46 INFO - ##### 17:46:46 INFO - ##### Running run-tests step. 17:46:46 INFO - ##### 17:46:46 INFO - Running pre-action listener: _resource_record_pre_action 17:46:46 INFO - Running main action method: run_tests 17:46:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:46:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:46:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:46:46 INFO - 2016-02-08 17:46:46.550 screenresolution[1649:7532] starting screenresolution argv=screenresolution get 17:46:46 INFO - 2016-02-08 17:46:46.553 screenresolution[1649:7532] Display 0: 1600x1200x32@60 17:46:46 INFO - 2016-02-08 17:46:46.558 screenresolution[1650:7534] starting screenresolution argv=screenresolution list 17:46:46 INFO - Available Modes on Display 0 17:46:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:46:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:46:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:46:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:46:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:46:46 INFO - Intel Iris: 17:46:46 INFO - Chipset Model: Intel Iris 17:46:46 INFO - Type: GPU 17:46:46 INFO - Bus: Built-In 17:46:46 INFO - VRAM (Dynamic, Max): 1536 MB 17:46:46 INFO - Vendor: Intel (0x8086) 17:46:46 INFO - Device ID: 0x0a2e 17:46:46 INFO - Revision ID: 0x0009 17:46:46 INFO - Displays: 17:46:46 INFO - Display: 17:46:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:46:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:46:46 INFO - Display Serial Number: 1600x1200 60 17:46:46 INFO - Main Display: Yes 17:46:46 INFO - Mirror: Off 17:46:46 INFO - Online: Yes 17:46:46 INFO - Rotation: Supported 17:46:46 INFO - Return code: 0 17:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:46:46 INFO - Python 2.7.3 17:46:46 INFO - Return code: 0 17:46:46 INFO - grabbing minidump binary from tooltool 17:46:46 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')]} 17:46:46 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 0x1014ead30>, '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 0x10130edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:46:46 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 17:46:46 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 17:46:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:46:46 INFO - Return code: 0 17:46:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:46:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:46:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:46:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:46:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:46:48 INFO - Return code: 0 17:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:46:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5z00Ma2NOn/Render', 17:46:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:48 INFO - 'HOME': '/Users/cltbld', 17:46:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:48 INFO - 'LOGNAME': 'cltbld', 17:46:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:46:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:48 INFO - 'MOZ_NO_REMOTE': '1', 17:46:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:46:48 INFO - 'NO_EM_RESTART': '1', 17:46:48 INFO - 'PAGER': '/bin/cat', 17:46:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:48 INFO - 'PWD': '/builds/slave/test', 17:46:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:46:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:48 INFO - 'SHELL': '/bin/bash', 17:46:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fPm8aPzOIJ/Listeners', 17:46:48 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 17:46:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:48 INFO - 'USER': 'cltbld', 17:46:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:48 INFO - 'XPC_FLAGS': '0x0', 17:46:48 INFO - 'XPC_SERVICE_NAME': '0', 17:46:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:46:48 INFO - mozversion application_buildid: 20160208164823 17:46:48 INFO - mozversion application_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 17:46:48 INFO - mozversion application_display_name: Nightly 17:46:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:46:48 INFO - mozversion application_name: Firefox 17:46:48 INFO - mozversion application_remotingname: firefox 17:46:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:46:48 INFO - mozversion application_vendor: Mozilla 17:46:48 INFO - mozversion application_version: 47.0a1 17:46:48 INFO - mozversion platform_buildid: 20160208164823 17:46:48 INFO - mozversion platform_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 17:46:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:46:48 INFO - mozversion platform_version: 47.0a1 17:46:48 INFO - using testdate: 1454982408 17:46:48 INFO - actual date: 1454982408 17:46:48 INFO - starting webserver on 'localhost:49279' 17:46:48 INFO - SUITE-START | Running 2 tests 17:46:48 INFO - TEST-START | dromaeo_css 17:46:48 INFO - operating with platform_type : mac_ 17:46:48 INFO - Initialising browser for dromaeo_css test... 17:46:48 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmp3hjYN8/profile http://localhost:49279/getInfo.html) 17:46:51 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 17:46:51 INFO - PROCESS | 1668 | colorDepth:24 17:46:51 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 17:46:51 INFO - PROCESS | 1668 | __metrics 17:46:52 INFO - TEST-INFO | 1668: exit 0 17:46:52 INFO - Browser initialized. 17:46:52 INFO - Running cycle 1/1 for dromaeo_css test... 17:46:52 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmp3hjYN8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:04 INFO - PROCESS | 1672 | RSS: Main: 257150976 17:47:04 INFO - PROCESS | 1672 | 17:47:54 INFO - PROCESS | 1672 | 1454982474271 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] 17:50:03 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 17:50:04 INFO - PROCESS | 1672 | RSS: Main: 272588800 17:50:04 INFO - PROCESS | 1672 | 17:53:06 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 17:53:07 INFO - PROCESS | 1672 | RSS: Main: 283574272 17:53:07 INFO - PROCESS | 1672 | 17:56:09 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 17:56:09 INFO - PROCESS | 1672 | RSS: Main: 284975104 17:56:09 INFO - PROCESS | 1672 | 17:59:11 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 17:59:11 INFO - PROCESS | 1672 | RSS: Main: 285798400 17:59:11 INFO - PROCESS | 1672 | 18:02:14 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 18:02:15 INFO - PROCESS | 1672 | RSS: Main: 289828864 18:02:15 INFO - PROCESS | 1672 | 18:05:17 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 18:05:17 INFO - PROCESS | 1672 | RSS: Main: 291827712 18:05:17 INFO - PROCESS | 1672 | 18:05:17 INFO - PROCESS | 1672 | __start_tp_report 18:05:17 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 18:05:17 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 18:05:17 INFO - PROCESS | 1672 | |i|pagename|runs| 18:05:17 INFO - PROCESS | 1672 | |0;dojo.html;2911.3012876909534;3088.382323535293;3450.775699579527;3496.6678165574262;3527.4532447470633;5582.748776305066;5633.15502674599;5636.549076073915;5655.20827084208;5674.744636491358;5329;5621.80323688671;5646.604737668365;5712.371639119693;5822.068469044953;5104.744762761866;5142.27459446494;5161.793528258865;5166.199239117943;5206.635535512516;285.92052017880553;4947.060058588874;5083.313752643383;5157.742112894359;5167.896642067157;5131.974340128276;5132.332796736419;5132.897342053138;5137.588992880579;5180.533751962323;5147.897042059138;5154.922676159823;5169.069567477853;5169.2504586835075;5214.947850521522;5016.372953380827;5036.622253331015;5131.461196574381;5132.640715149941;5142.871428214325;4459.754713490756;4480.865574032784;4530.388397566319;4576;5319.441458646825;6003.6397816131175;6138.47822935051;6180.6291622502795;6198.3801619838105;6225.252969643627;5544.1960915667405;5777.508911742507;6149.0776383542825;6150.200473938404;6150.231221097363;5711.543076553908;5712.628679135884;5725.398833122504;5733.254676891977;5741.540676745851;6137.631742095488;6139.631622102688;6141.240538582634;6192.349803270682;6235.189425374672;6065.60573562717;6098.841220168242;6112.299199283796;6115.839196380484;6142;6099.786507472217;6159.753609855646;6172.9074063889075;6175.44421002112;6178.258608966953;4913.828016019422;6097.512199024156;6143.692815359214;6200.224971878515;6237.812865613948;6141.692915354304;6227.501799856092;6232.220972378453;6242.313345531988;6257.155284036688;4796.856094317176;4823.9517604824205;4890.095332363524;4891.119598472309;4925.482824303468;4282.186384586981;4382.561743825656;4400.845970391021;4430.5126436092005;4431.534688857688;5594.468525490072;5656.830295091071;5697.686627235542;5712;5758.7696492140685;6100.3086879273915;6154.569180157436;6254.530910181755;6259.280182779039;6259.3427690091885;5730.255066841284;5752.683602401824;5753.683547404933;5760.683162426107;5773.913391299134;5353.518183363516;5359.276497672842;5361.27622770921;5392.379876314196;5396;5173.896522069537;5695.572832037614;6257.124002639634;6268.905966410507;6288.371162883766;6221.844453888689;6223.751049957951;6246.031865060922;6253.280872699698;6266.843328916631;6157.907631385443;6166.876662466636;6263.78076767311;6302.212223472066;6309;5045.4450010498085;5960.791372301948;6046.969765151146;6065.6663883486835;6117;6127.84680382994;6168.475679567287;6171.228596425447;6179.104029915727;6187.319394866471;5070.569001634903;5404;6069.423404776539;6131.1931684982055;6155.876882462236;4983.451820299837;6046.818595442144;6052.273727152769;6107.083937409424;6124.601900876429;5713.314402271754;5976.551758618208;5992.250968628921;6015.849603759766;6041.667708276087;5790.7973220937065;5943.138244954544;5982.790602328898;5987.31145918225;6038.184845045863;5876.118582212703;5906.497947674324;5919.141724450017;5928.170056192051;5933.525317974465 18:05:17 INFO - PROCESS | 1672 | |1;ext.html;437.81392908014107;467.54647991448303;502.4949925325048;561.977520899164;576.9413126912116;36614.901552953386;36906.44640330397;36989.81505092477;37157.256854862884;37216.25567488649;38844.61155388445;39153.80423097888;39349.60650393495;39423.802880985626;39469.40795888057;9417.85873211904;9563.904360956405;9611.663591774255;9628.662996795114;9631.470269135194;7846.607669616525;8763.868541971875;9378.249740020816;9481.194098501635;9526.571304291288;8264.83470330593;9564.234861211087;9650.372725772802;9667.5649595768;9711.417314961089;9571.760705982337;9628.229741620653;9644.18024467921;9647.083527064917;9652.806943861084;9675;9778.07108324708;9806.705798826046;9810.46042467664;9832.606695732162;38679.8396048119;38963.61036389628;39070.02324941871;39248.41127383091;39352.803235983636;2784.470950519395;3230.2731885325848;3280.4423248047888;3452.723782097426;3593.4250519916686;27985.720142798516;28444.146675599764;28487.57855582278;28626;29301.41397172066;2789.079603730764;2794.147784925597;2862.685104638488;2862.799604027719;2974.419988102321;479826;491661;492809;493206;511681.9999999963;69758;71678.64160679268;72231.6388418065;72258;72310;70627.64686176536;70779.6461017702;71409.6429517849;71576;71871.28128718646;16278.186090695655;16586.75119873203;16720.581985450463;16768.748468772978;16810.075445850594;12747.36263186837;13048.54330098442;13141.54004609834;13173.077884548182;13223.73552528944;22262;22666.206682766024;22700.091996320294;22764;22775.202867899545;9705.223582113415;9936.751581210383;9989.250806189564;10026.846912605144;10033.598656053677;897.6465232279533;967.351874244258;1089.3790539392471;1090.3948308688596;1141.6456817525777;28673.426531469253;28868.566971495446;29059.854700726362;29076.563851542243;29324;1052.0899422000068;1129.9774004519863;1139.316410153901;1175.6002958993984;1253.7116463213513;15551.455699050704;15732.92133539348;15753.842461575467;15861.365545378056;16134.435294764628;652938;654825;656454;657319;658780;56861.715691422105;57451;57484.71257643685;57811.42188578145;58035.709821450626;1459.5183589415467;1468.9706205875823;1481.659218379757;1491.7240310542584;1596.3933705192185;28607.284817878888;28881.075573845414;28977.13068607945;29597.5560366599;29765.702342976292;40291.395629065;46444.6066618002;47039.76480117578;47042.52957470382;47768.76115619539;503276;503933;506261;506495;506866;31429.214269643442;41950.79024604857;43171.78414107909;43436.78281608572;43488.56511434845;47842.760786195846;49695;50396;51172.48827511826;51230.487695124066;33143.83428082844;37883;38484.80757596194;38712.80643596876;39084;37351.43972840355;37926.62073379341;38261;39180.804095979336;39247;38800.611993880826;39327.6067239324;39381;39455.408168876915;40136.799316003235;33046.66953330436;34783.82608086943;35280.823595881855;36190.27619447544;36245;20996.448342228796;22541;24177.63733543963;25212.62181067249;26523.07169249067 18:05:17 INFO - PROCESS | 1672 | |2;jquery.html;359.5397890699905;365.8573156468977;367.2709671302464;367.29479399552855;371.22969837587016;15132.546023619281;18727.344542941;18964.905175474138;19188.616227675437;19857.80853148812;19084.33204837831;19251.807481925178;19553.902230488828;19572.02139893007;19585.412437626896;4007.398890166484;4581.518940511231;5222.660527065738;5462;5797.5651826113;5904.7342869570975;5928.940710592882;5967.40325967402;5968.224130863004;5979.551533634973;5670.121131224667;5765.596408251424;5808.390119037504;5938;5941.762329506814;5657.264555607765;5840.970795146019;5854.560907931922;5893.5579831512805;5955.225820643332;5576.275084239063;5622.634528755618;5633.408492108351;5644.6330988485615;5668.922904648103;12078.69803254917;12579.496820127275;12606;12628.621141365773;17300.48098557045;2017.6368253714325;2040.3980825656467;2233.1960494222067;2352.1649814315842;2425.672534207895;9464.242860571137;9687.54686796986;9767.51162441875;9797.236497430531;9828.655997040141;1631.6899789040044;1674.8073971493313;1718.1237568839856;1757.3058641836403;1798.307651554148;98795.86527247544;104381;104620;105207;105609.94390056079;11215.158863085302;11323.263987840928;11345.886541134483;11390.65828025144;11439.59961401347;13432;13555.796663050061;13569.914406847429;13571.796423053662;13600.775930166332;7360.926390736131;8502.532360720219;8512.829743405096;8553.914460855312;8608.741737747752;7017.89473157903;8627.654893804303;8639.78400539979;8672.81335659108;8688.91311086881;3577.8908538353194;4017.4375587417785;4239.872803815891;4357.281048627005;4428.180786554498;1859.674556952555;1877.6995680691298;1908.4370110817342;1942.931997380085;1943.3295513047976;855.3584811391456;865.4201684871151;1038.0916697889347;1050.0392141190725;1051.7859904900229;18083.909580452015;19010.80989190118;19179.712304315446;19485.610287794163;19635;888.5335199020566;925.4031149908271;932.1331162019387;935.1116439382478;1022.2486472442748;9865.901340986498;9897.802043959224;10675.83986240207;11049.33703977764;11211.327320360804;697709;711839;713685;720803;725935;67791;87044;102170.48914755379;107889;113016;1179.7404570994368;1181.0610564601163;1183.923045002072;1218.2812140836772;1222.914395992272;13473.595792126252;17601.82398176002;17740.93554386741;17917.64164716672;18070.367537136663;45030.77484612556;47625;49196;49315.50684493109;50426.478676065315;62526.74946500953;67158.65682686417;67971.66014169897;68232.97650535147;68696;5725.2843394575675;7440;7596.772096837104;7656.770296891103;7711.691532338644;10923.508442119964;11388.145889058189;11866.347350895783;11883.881161188277;12141.392930353624;3755.9812200938823;3837.0791010156804;8568.785780355542;10085.125739164303;10508.159347252355;9449.763755906157;10171.881093079608;10288.331258468475;10333.586656533955;10460.26778125524;10367.0151335623;10444.321119127233;10603.764773681385;10729.195310351912;10742.946285268523;6266.467350275278;7480.92519074824;7599.278068583476;7624.199459056719;7705.730299439493;7332.596707180943;10232;10307.690769276935;10367.896321036995;10368.844467333147 18:05:17 INFO - PROCESS | 1672 | |3;mootools.html;1542.753159494481;1548.6360705234272;1781.8129096444873;1874.2784028149167;1899.9240030398785;7856.489328193664;8526.445781024244;8575;8765.912340876597;8883.02286748458;7750.573718445483;8007.879881801763;8561.48631082134;8670.393072484929;8670.52312122833;2457.901683932645;2457.9754202457925;2460.790832779216;2461.4461746107163;2473.319837044809;2028.5435776950142;2400.6519054737055;2440.7559244075537;2440.9511809763794;2443.7067551893797;2003.6994450832347;2190.463336482564;2421.140495124232;2443.0105807148134;2488.191337815208;2016.5462770876509;2395.197608801054;2446.7675570820743;2475.665785119013;2483.3170878008514;2290.7022087128735;2372.181597348912;2387.248016874679;2393.940151496209;2413.613821788523;6441.871162576722;7614.505057171266;8044.034715834137;8567.528785916773;8612.52631105289;5156.020356132361;5315.734213289359;5410;5504.146857237135;5504.752286147133;3278.6885245901603;3625.365561026836;3700.8704695335805;3736.953652977171;3753.080495278647;911.9908800912038;1059.1050562274866;1071.9249652524327;1093.6882988348361;1094.895984881435;11835.763284734343;11947;11959.461824217844;11969.581064662782;11974;4862.954464790017;4913.680610760289;4923.532264434873;4962.478939711351;5011.649184557046;9955.104040636377;10257.538410771533;10257.692269231935;10282.742931426774;10312.071913527818;5450.5639548836;5452.127659574449;5469.042917489423;5471.069918113851;5480.671159730429;4879.072976134594;4945.851624451272;4984.526469985346;4994.2508623706735;5001.024800163933;3438.8108654023767;3899.8885317684326;3911.7457365271166;3939.5863434339553;3951.8024098794945;1226.8405107335989;1311.9737605248033;1312.2126723965544;1316.6379245707508;1322.510671051717;1080.3247970018738;1099.8790133085354;1109.0850048709847;1249.631358749171;1357;7823.56970366624;7901.802454938557;7959.562224077731;7972.481788683717;7994.760157195294;1025.5795123999123;1178.1458442629025;1178.3460179600404;1183.2959389163434;1196.0551164580058;6052.515798736179;6107.511399088063;6141.631502109888;6157.568970172135;6232;10154.390736555682;10635.627753028606;10672.039516443401;10767.515461804081;10785.46072696362;10315.484225788681;10545.209109316833;10582.417967011888;10602.151827853753;10702.625408110678;8257.174282571696;8272.131426200283;8291.08798032228;8308.626111824982;8416;7698.384129269533;7788;7790.9220907790195;7814.960925195338;7836.764897053097;7339.522931009467;9451.385659932082;9557.569909353957;9570.56932438028;9650.034996500293;7964.840703185788;9318.02160773109;9584.37701549397;9689.12797848197;9724.95137524308;7337.229590892879;7439.55362678241;7442.255774422514;7488.288612581796;7491.70033198666;7915.1293357729455;8045.07481639619;8118.066422361504;8124.67501299965;8182.83634327322;6993.370596646327;7723.652435640522;7810.453268271166;7888.881666774888;8051.919480805352;7489.962550187214;7502.287282708352;7514.549127052394;7614.961925190339;7629.618519074135;7641.617919103911;7717.382609391348;7761.456698031084;7773.805654858674;7780.260875216845;6878.243393226641;6921.996310534843;6946.548474349152;6953.165620125617;6976.511644185061;6066.848328791639;6294.339094395205;6503.122078519528;6956.060931774348;7010.719571217298 18:05:17 INFO - PROCESS | 1672 | |4;prototype.html;276.64451180233397;325.6645654975375;329.41364371418865;336.3239887825473;338.4652249445874;5399.433059528752;6720.5295629305965;6844.247132815392;6983.952407138925;6989.064592870994;6803.829904252396;6886.0703804986315;6899.4135498482565;6945.652717364124;6967.338102880219;4657.464391594976;5037.748112594374;5116.923246151292;5117.769700363493;5123.5388815006645;4210.347396153586;4367.908022994251;5117.974410127944;5125.589952803767;5145.459726728677;3946.3883098119836;4281.871543853689;4695.178343789823;5025.597952163818;5027;5028.396592408898;5033.119204139261;5034.09386310464;5040.521150490697;5045.394552653668;4083.081306705997;4169.082801783603;4251.107267473834;4319.784010799447;4340.001799586113;6508.934910650928;6513.902291465632;6521.510886683518;6561.376669216417;6581.835454113638;5421.756020979065;5502.394736578973;5994.700264986734;6023.006203976339;6027.7287522061615;6753.425958793459;6911.686779511877;7370.963145184293;7387.7783666490095;7411.407087432993;3947.50656167979;4848.030393921194;4853.878653033667;4859.07677541266;4870.975645121787;7831.960840195819;7834;7844.137144914055;7852.882206766903;7882.960585197095;4809.350737650442;4912.164931961575;4922.409310882717;4929.644347804382;4941;5029.270755740397;5044.1677123274985;5047.369078865142;5048.5203905628905;5063.87340316495;5266.710330931835;5640.125780504029;5990.101484777231;5991.400859913973;6014.51883849291;6799.5920244785475;6878.661087866109;7417.8145546361775;7455.329020388191;7468.21583733711;1407.3737186951912;1755.1750677181703;1756.6223261998475;1757.5254681235995;1759.780027496563;1127.1095834290818;1133.7052366384635;1136.8067428537167;1141.4007645985757;1149.7815415071277;6672.9656903180085;6876.381125698711;6876.931230687729;6885.173779146434;6903.068085808452;6519.576227545194;7759.495632783851;7767.300942915164;7767.53394796314;7771.572563508948;6692.18494552082;6844.007618895332;6860.176778786477;6892.276310987374;6892.689828957608;3200.5839240898536;4020.778857162884;4069.877903662895;4070.043539768152;4157.043879907577;6411.871762564816;7046.449781048162;7416.851662966818;8005.719799806979;8128.59357032146;6756.459483241329;7745.760678291446;8019.478733882279;8039.638216280281;8084.3936704747375;6963.850964590988;7884.763457096296;8122.7157049502985;8233.053198882206;8239.340852731768;7693.230676932262;7905.920940790518;7912.129665736879;7915.129335773176;7990.121086680577;7479;7729.729459468892;7730.613469326624;7731.690732370642;7735.845283094419;8172.5913704315735;8176.550289734122;8188.344932405513;8193.67225310981;8262.380321475794;4813.711177329372;4858.319835223142;4858.44127925279;4863.270509423473;4877.487863774252;5873.442023007808;6097.75608975636;7806.453548251568;7845.333146682596;7857.842843143219;6097.451229389376;7556.093268807558;7574.204708505527;7580.507267027626;7583.696652133853;6228.785386849521;7465.216152303929;7533.547987120571;7540.434467415075;7554.093508778982;7153.821154470972;7389.261073892568;7390.895823753929;7396.890466430079;7397.630118494161;7535.13345965221;7545.7358992435;7547.849043019219;7573.810654733676;7584.924150758642;7220.3140701633265;7303.744368947061;7356.852862942818;7357.632118393952;7389.8152546186775 18:05:17 INFO - PROCESS | 1672 | |5;yui.html;639.6801599200397;640.5516138702909;641.2433328672167;682.7576210445292;705.7106586299618;14948.551543453701;14953;14983.175925324103;15257.465988690397;15283.694326113471;13747.793783093262;13779.44882204713;13799.2410417427;13811.861881381183;13813.930930345334;671.983200419991;823.7775800533882;837.673307410109;842.5492361586553;853.9837593264027;698.0088274650009;734.9044624198847;841.0412130171609;844.6536919862857;855.2559273432123;884.3455842676406;885.8316919785252;893.4728510178993;897.1611543207122;897.4525539420948;870.8127752533236;879.3404946290283;889.3863234368298;891.1534042659499;892.0187793427243;652.9738810447576;656.1109696361457;658.3975662269019;666.5833853841349;667.7796327212056;14477.710445791025;14816.259187040605;14888.404463821542;14905.850941490555;15007.474738384104;10498;12499.437525311383;12576.81134782979;12861.742765144645;13537.766684495218;10190.59237630494;10198.694039178836;10218.9489052555;10228.232882533839;10238.53926573306;3493.6506349365113;3507.754457187998;3525.048236976002;3528.2943411317838;3531.470279458076;73134.26865731328;73966.26033739648;74245;74645.62677186633;85054;9382.906170938204;9507.857382139273;9557.187639050759;9643.373180743229;9658.082482164184;19906.90046549758;20049.59900802005;20070.89964550168;20074.096665650082;20107.798922010887;7328.633568321563;7496.400287976949;7537.623118844036;7716.382689384835;7763.495372800863;4161.0637606538285;4181.707280490336;4220.240356735756;4233.809478573472;4247.384129301234;3530.2057037166433;3575.6424357564038;3581.4806853006166;3585.659362360572;3594.982025089858;550.3615805665409;647.3170804800886;650;654.2900952466532;678.494521581425;544.4337888595816;583.3961849485762;594.3610618584952;610.9725062372204;635.9665543491826;8359.665613375519;8617.82764344722;8691.004276065909;8692.478451292816;8710.738677839676;518.8210067526697;578.9826305210767;599.349705569462;602.3584882100549;613.6471528870917;3901.3757798752063;4338.978305108454;4368.781560922005;4379.211741886427;4397.40635014269;63220.68389658114;81125.16061937803;85420.57289713636;85541;85655.57172214099;73379.63310183414;73972.26027739761;74696;74989;75159.24840751632;65700.3574910631;66777.33222667809;66928.66535667291;66946.33053669498;67657.98513022308;6934.618595977068;7511;8720.43317184381;8800;8937.776555585902;45136.322955156356;47641.761791190824;47973.280400793315;48013;48087.75956120337;67435.66282168558;67529.3247067523;67543.97368078966;68008;68425.3157468419;11144.721381965515;11158.832617510907;11325.71685707864;11490.138239631893;12039.75920481603;9463;9783.902160978583;11942.70143246391;13251.602451926457;13270.1374410663;11039.227254092137;11903.642890713292;12055.879441205476;12063.336516491678;12272.443656874877;11466.31202127875;11641.41792910368;11667.708307292385;11931.164818462625;12390.62828115158;11409.942950285196;11471.541138354372;11725.530978760755;11827.231229970024;12393.132480726263;9044.592993315448;9339.859902101338;9412.435253884789;9581.664641737505;10071.848922266025;9230.662627942418;9271.773451679524;9531.761705957406;9926.205903527845;10001.799964000533 18:05:17 INFO - PROCESS | 1672 | __end_tp_report 18:05:17 INFO - PROCESS | 1672 | __start_cc_report 18:05:17 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,376 18:05:17 INFO - PROCESS | 1672 | __end_cc_report 18:05:17 INFO - PROCESS | 1672 | __startTimestamp1454983517608__endTimestamp 18:05:17 INFO - PROCESS | 1672 | 18:05:17 INFO - PROCESS | 1672 | ------- Summary: start ------- 18:05:17 INFO - PROCESS | 1672 | Number of tests: 6 18:05:17 INFO - PROCESS | 1672 | 18:05:17 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5589.73 Median:5773.91 stddev:785.55 (13.6%) stddev-sans-first:759.34 18:05:17 INFO - PROCESS | 1672 | Values: 2911.3 3088.4 3450.8 3496.7 3527.5 5582.7 5633.2 5636.5 5655.2 5674.7 5329.0 5621.8 5646.6 5712.4 5822.1 5104.7 5142.3 5161.8 5166.2 5206.6 285.9 4947.1 5083.3 5157.7 5167.9 5132.0 5132.3 5132.9 5137.6 5180.5 5147.9 5154.9 5169.1 5169.3 5214.9 5016.4 5036.6 5131.5 5132.6 5142.9 4459.8 4480.9 4530.4 4576.0 5319.4 6003.6 6138.5 6180.6 6198.4 6225.3 5544.2 5777.5 6149.1 6150.2 6150.2 5711.5 5712.6 5725.4 5733.3 5741.5 6137.6 6139.6 6141.2 6192.3 6235.2 6065.6 6098.8 6112.3 6115.8 6142.0 6099.8 6159.8 6172.9 6175.4 6178.3 4913.8 6097.5 6143.7 6200.2 6237.8 6141.7 6227.5 6232.2 6242.3 6257.2 4796.9 4824.0 4890.1 4891.1 4925.5 4282.2 4382.6 4400.8 4430.5 4431.5 5594.5 5656.8 5697.7 5712.0 5758.8 6100.3 6154.6 6254.5 6259.3 6259.3 5730.3 5752.7 5753.7 5760.7 5773.9 5353.5 5359.3 5361.3 5392.4 5396.0 5173.9 5695.6 6257.1 6268.9 6288.4 6221.8 6223.8 6246.0 6253.3 6266.8 6157.9 6166.9 6263.8 6302.2 6309.0 5045.4 5960.8 6047.0 6065.7 6117.0 6127.8 6168.5 6171.2 6179.1 6187.3 5070.6 5404.0 6069.4 6131.2 6155.9 4983.5 6046.8 6052.3 6107.1 6124.6 5713.3 5976.6 5992.3 6015.8 6041.7 5790.8 5943.1 5982.8 5987.3 6038.2 5876.1 5906.5 5919.1 5928.2 5933.5 18:05:17 INFO - PROCESS | 1672 | 18:05:17 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:69561.79 Median:39213.90 stddev:148585.06 (378.9%) stddev-sans-first:148911.24 18:05:17 INFO - PROCESS | 1672 | Values: 437.8 467.5 502.5 562.0 576.9 36614.9 36906.4 36989.8 37157.3 37216.3 38844.6 39153.8 39349.6 39423.8 39469.4 9417.9 9563.9 9611.7 9628.7 9631.5 7846.6 8763.9 9378.2 9481.2 9526.6 8264.8 9564.2 9650.4 9667.6 9711.4 9571.8 9628.2 9644.2 9647.1 9652.8 9675.0 9778.1 9806.7 9810.5 9832.6 38679.8 38963.6 39070.0 39248.4 39352.8 2784.5 3230.3 3280.4 3452.7 3593.4 27985.7 28444.1 28487.6 28626.0 29301.4 2789.1 2794.1 2862.7 2862.8 2974.4 479826.0 491661.0 492809.0 493206.0 511682.0 69758.0 71678.6 72231.6 72258.0 72310.0 70627.6 70779.6 71409.6 71576.0 71871.3 16278.2 16586.8 16720.6 16768.7 16810.1 12747.4 13048.5 13141.5 13173.1 13223.7 22262.0 22666.2 22700.1 22764.0 22775.2 9705.2 9936.8 9989.3 10026.8 10033.6 897.6 967.4 1089.4 1090.4 1141.6 28673.4 28868.6 29059.9 29076.6 29324.0 1052.1 1130.0 1139.3 1175.6 1253.7 15551.5 15732.9 15753.8 15861.4 16134.4 652938.0 654825.0 656454.0 657319.0 658780.0 56861.7 57451.0 57484.7 57811.4 58035.7 1459.5 1469.0 1481.7 1491.7 1596.4 28607.3 28881.1 28977.1 29597.6 29765.7 40291.4 46444.6 47039.8 47042.5 47768.8 503276.0 503933.0 506261.0 506495.0 506866.0 31429.2 41950.8 43171.8 43436.8 43488.6 47842.8 49695.0 50396.0 51172.5 51230.5 33143.8 37883.0 38484.8 38712.8 39084.0 37351.4 37926.6 38261.0 39180.8 39247.0 38800.6 39327.6 39381.0 39455.4 40136.8 33046.7 34783.8 35280.8 36190.3 36245.0 20996.4 22541.0 24177.6 25212.6 26523.1 18:05:17 INFO - PROCESS | 1672 | 18:05:17 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:35646.13 Median:362.70 stddev:117486.39 (32392.3%) stddev-sans-first:117786.09 18:05:17 INFO - PROCESS | 1672 | Values: 359.5 365.9 367.3 367.3 371.2 15132.5 18727.3 18964.9 19188.6 19857.8 19084.3 19251.8 19553.9 19572.0 19585.4 4007.4 4581.5 5222.7 5462.0 5797.6 5904.7 5928.9 5967.4 5968.2 5979.6 5670.1 5765.6 5808.4 5938.0 5941.8 5657.3 5841.0 5854.6 5893.6 5955.2 5576.3 5622.6 5633.4 5644.6 5668.9 12078.7 12579.5 12606.0 12628.6 17300.5 2017.6 2040.4 2233.2 2352.2 2425.7 9464.2 9687.5 9767.5 9797.2 9828.7 1631.7 1674.8 1718.1 1757.3 1798.3 98795.9 104381.0 104620.0 105207.0 105609.9 11215.2 11323.3 11345.9 11390.7 11439.6 13432.0 13555.8 13569.9 13571.8 13600.8 7360.9 8502.5 8512.8 8553.9 8608.7 7017.9 8627.7 8639.8 8672.8 8688.9 3577.9 4017.4 4239.9 4357.3 4428.2 1859.7 1877.7 1908.4 1942.9 1943.3 855.4 865.4 1038.1 1050.0 1051.8 18083.9 19010.8 19179.7 19485.6 19635.0 888.5 925.4 932.1 935.1 1022.2 9865.9 9897.8 10675.8 11049.3 11211.3 697709.0 711839.0 713685.0 720803.0 725935.0 67791.0 87044.0 102170.5 107889.0 113016.0 1179.7 1181.1 1183.9 1218.3 1222.9 13473.6 17601.8 17740.9 17917.6 18070.4 45030.8 47625.0 49196.0 49315.5 50426.5 62526.7 67158.7 67971.7 68233.0 68696.0 5725.3 7440.0 7596.8 7656.8 7711.7 10923.5 11388.1 11866.3 11883.9 12141.4 3756.0 3837.1 8568.8 10085.1 10508.2 9449.8 10171.9 10288.3 10333.6 10460.3 10367.0 10444.3 10603.8 10729.2 10742.9 6266.5 7480.9 7599.3 7624.2 7705.7 7332.6 10232.0 10307.7 10367.9 10368.8 18:05:17 INFO - PROCESS | 1672 | 18:05:17 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:5972.00 Median:5430.28 stddev:3135.78 (57.7%) stddev-sans-first:3126.90 18:05:17 INFO - PROCESS | 1672 | Values: 1542.8 1548.6 1781.8 1874.3 1899.9 7856.5 8526.4 8575.0 8765.9 8883.0 7750.6 8007.9 8561.5 8670.4 8670.5 2457.9 2458.0 2460.8 2461.4 2473.3 2028.5 2400.7 2440.8 2441.0 2443.7 2003.7 2190.5 2421.1 2443.0 2488.2 2016.5 2395.2 2446.8 2475.7 2483.3 2290.7 2372.2 2387.2 2393.9 2413.6 6441.9 7614.5 8044.0 8567.5 8612.5 5156.0 5315.7 5410.0 5504.1 5504.8 3278.7 3625.4 3700.9 3737.0 3753.1 912.0 1059.1 1071.9 1093.7 1094.9 11835.8 11947.0 11959.5 11969.6 11974.0 4863.0 4913.7 4923.5 4962.5 5011.6 9955.1 10257.5 10257.7 10282.7 10312.1 5450.6 5452.1 5469.0 5471.1 5480.7 4879.1 4945.9 4984.5 4994.3 5001.0 3438.8 3899.9 3911.7 3939.6 3951.8 1226.8 1312.0 1312.2 1316.6 1322.5 1080.3 1099.9 1109.1 1249.6 1357.0 7823.6 7901.8 7959.6 7972.5 7994.8 1025.6 1178.1 1178.3 1183.3 1196.1 6052.5 6107.5 6141.6 6157.6 6232.0 10154.4 10635.6 10672.0 10767.5 10785.5 10315.5 10545.2 10582.4 10602.2 10702.6 8257.2 8272.1 8291.1 8308.6 8416.0 7698.4 7788.0 7790.9 7815.0 7836.8 7339.5 9451.4 9557.6 9570.6 9650.0 7964.8 9318.0 9584.4 9689.1 9725.0 7337.2 7439.6 7442.3 7488.3 7491.7 7915.1 8045.1 8118.1 8124.7 8182.8 6993.4 7723.7 7810.5 7888.9 8051.9 7490.0 7502.3 7514.5 7615.0 7629.6 7641.6 7717.4 7761.5 7773.8 7780.3 6878.2 6922.0 6946.5 6953.2 6976.5 6066.8 6294.3 6503.1 6956.1 7010.7 18:05:17 INFO - PROCESS | 1672 | 18:05:17 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5996.26 Median:6754.94 stddev:1964.41 (29.1%) stddev-sans-first:1922.44 18:05:17 INFO - PROCESS | 1672 | Values: 276.6 325.7 329.4 336.3 338.5 5399.4 6720.5 6844.2 6984.0 6989.1 6803.8 6886.1 6899.4 6945.7 6967.3 4657.5 5037.7 5116.9 5117.8 5123.5 4210.3 4367.9 5118.0 5125.6 5145.5 3946.4 4281.9 4695.2 5025.6 5027.0 5028.4 5033.1 5034.1 5040.5 5045.4 4083.1 4169.1 4251.1 4319.8 4340.0 6508.9 6513.9 6521.5 6561.4 6581.8 5421.8 5502.4 5994.7 6023.0 6027.7 6753.4 6911.7 7371.0 7387.8 7411.4 3947.5 4848.0 4853.9 4859.1 4871.0 7832.0 7834.0 7844.1 7852.9 7883.0 4809.4 4912.2 4922.4 4929.6 4941.0 5029.3 5044.2 5047.4 5048.5 5063.9 5266.7 5640.1 5990.1 5991.4 6014.5 6799.6 6878.7 7417.8 7455.3 7468.2 1407.4 1755.2 1756.6 1757.5 1759.8 1127.1 1133.7 1136.8 1141.4 1149.8 6673.0 6876.4 6876.9 6885.2 6903.1 6519.6 7759.5 7767.3 7767.5 7771.6 6692.2 6844.0 6860.2 6892.3 6892.7 3200.6 4020.8 4069.9 4070.0 4157.0 6411.9 7046.4 7416.9 8005.7 8128.6 6756.5 7745.8 8019.5 8039.6 8084.4 6963.9 7884.8 8122.7 8233.1 8239.3 7693.2 7905.9 7912.1 7915.1 7990.1 7479.0 7729.7 7730.6 7731.7 7735.8 8172.6 8176.6 8188.3 8193.7 8262.4 4813.7 4858.3 4858.4 4863.3 4877.5 5873.4 6097.8 7806.5 7845.3 7857.8 6097.5 7556.1 7574.2 7580.5 7583.7 6228.8 7465.2 7533.5 7540.4 7554.1 7153.8 7389.3 7390.9 7396.9 7397.6 7535.1 7545.7 7547.8 7573.8 7584.9 7220.3 7303.7 7356.9 7357.6 7389.8 18:05:17 INFO - PROCESS | 1672 | 18:05:17 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:17573.86 Median:31928.33 stddev:23978.09 (75.1%) stddev-sans-first:24011.64 18:05:17 INFO - PROCESS | 1672 | Values: 639.7 640.6 641.2 682.8 705.7 14948.6 14953.0 14983.2 15257.5 15283.7 13747.8 13779.4 13799.2 13811.9 13813.9 672.0 823.8 837.7 842.5 854.0 698.0 734.9 841.0 844.7 855.3 884.3 885.8 893.5 897.2 897.5 870.8 879.3 889.4 891.2 892.0 653.0 656.1 658.4 666.6 667.8 14477.7 14816.3 14888.4 14905.9 15007.5 10498.0 12499.4 12576.8 12861.7 13537.8 10190.6 10198.7 10218.9 10228.2 10238.5 3493.7 3507.8 3525.0 3528.3 3531.5 73134.3 73966.3 74245.0 74645.6 85054.0 9382.9 9507.9 9557.2 9643.4 9658.1 19906.9 20049.6 20070.9 20074.1 20107.8 7328.6 7496.4 7537.6 7716.4 7763.5 4161.1 4181.7 4220.2 4233.8 4247.4 3530.2 3575.6 3581.5 3585.7 3595.0 550.4 647.3 650.0 654.3 678.5 544.4 583.4 594.4 611.0 636.0 8359.7 8617.8 8691.0 8692.5 8710.7 518.8 579.0 599.3 602.4 613.6 3901.4 4339.0 4368.8 4379.2 4397.4 63220.7 81125.2 85420.6 85541.0 85655.6 73379.6 73972.3 74696.0 74989.0 75159.2 65700.4 66777.3 66928.7 66946.3 67658.0 6934.6 7511.0 8720.4 8800.0 8937.8 45136.3 47641.8 47973.3 48013.0 48087.8 67435.7 67529.3 67544.0 68008.0 68425.3 11144.7 11158.8 11325.7 11490.1 12039.8 9463.0 9783.9 11942.7 13251.6 13270.1 11039.2 11903.6 12055.9 12063.3 12272.4 11466.3 11641.4 11667.7 11931.2 12390.6 11409.9 11471.5 11725.5 11827.2 12393.1 9044.6 9339.9 9412.4 9581.7 10071.8 9230.7 9271.8 9531.8 9926.2 10001.8 18:05:17 INFO - PROCESS | 1672 | -------- Summary: end -------- 18:05:17 INFO - PROCESS | 1672 | 18:05:18 INFO - TEST-INFO | 1672: exit 0 18:05:18 INFO - TEST-OK | dromaeo_css | took 1109336ms 18:05:18 INFO - TEST-START | kraken 18:05:18 INFO - operating with platform_type : mac_ 18:05:18 INFO - Initialising browser for kraken test... 18:05:18 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpofq41S/profile http://localhost:49279/getInfo.html) 18:05:21 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 18:05:21 INFO - PROCESS | 1684 | colorDepth:24 18:05:21 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 18:05:21 INFO - PROCESS | 1684 | __metrics 18:05:21 INFO - PROCESS | 1684 | 18:05:21 INFO - PROCESS | 1684 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 18:05:21 INFO - PROCESS | 1684 | 18:05:21 INFO - TEST-INFO | 1684: exit 0 18:05:21 INFO - Browser initialized. 18:05:21 INFO - Running cycle 1/1 for kraken test... 18:05:21 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpofq41S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:05:33 INFO - PROCESS | 1687 | RSS: Main: 258179072 18:05:33 INFO - PROCESS | 1687 | 18:05:36 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 18:05:37 INFO - PROCESS | 1687 | RSS: Main: 271458304 18:05:37 INFO - PROCESS | 1687 | 18:05:39 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 18:05:40 INFO - PROCESS | 1687 | RSS: Main: 279293952 18:05:40 INFO - PROCESS | 1687 | 18:05:43 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 18:05:44 INFO - PROCESS | 1687 | RSS: Main: 281595904 18:05:44 INFO - PROCESS | 1687 | 18:05:46 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 18:05:46 INFO - PROCESS | 1687 | RSS: Main: 282501120 18:05:46 INFO - PROCESS | 1687 | 18:05:48 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:05:49 INFO - PROCESS | 1687 | RSS: Main: 283054080 18:05:49 INFO - PROCESS | 1687 | 18:05:52 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 18:05:52 INFO - PROCESS | 1687 | RSS: Main: 285257728 18:05:52 INFO - PROCESS | 1687 | 18:05:55 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 18:05:56 INFO - PROCESS | 1687 | RSS: Main: 284356608 18:05:56 INFO - PROCESS | 1687 | 18:05:59 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 18:05:59 INFO - PROCESS | 1687 | RSS: Main: 284573696 18:05:59 INFO - PROCESS | 1687 | 18:06:01 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:06:01 INFO - PROCESS | 1687 | RSS: Main: 286023680 18:06:01 INFO - PROCESS | 1687 | 18:06:03 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:06:04 INFO - PROCESS | 1687 | RSS: Main: 284987392 18:06:04 INFO - PROCESS | 1687 | 18:06:06 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:06:07 INFO - PROCESS | 1687 | RSS: Main: 285478912 18:06:07 INFO - PROCESS | 1687 | 18:06:09 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:06:10 INFO - PROCESS | 1687 | RSS: Main: 285229056 18:06:10 INFO - PROCESS | 1687 | 18:06:13 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:06:13 INFO - PROCESS | 1687 | RSS: Main: 285081600 18:06:13 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 18:06:15 INFO - PROCESS | 1687 | RSS: Main: 286826496 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | __start_tp_report 18:06:15 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 18:06:15 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 18:06:15 INFO - PROCESS | 1687 | |i|pagename|runs| 18:06:15 INFO - PROCESS | 1687 | |0;ai-astar;117;109;116;113;116;129;143;92;135;171 18:06:15 INFO - PROCESS | 1687 | |1;audio-beat-detection;152;146;138;182;155;170;133;156;172;157 18:06:15 INFO - PROCESS | 1687 | |2;audio-dft;192;199;196;218;214;198;199;199;206;194 18:06:15 INFO - PROCESS | 1687 | |3;audio-fft;76;72;70;110;58;56;64;61;115;57 18:06:15 INFO - PROCESS | 1687 | |4;audio-oscillator;82;82;119;72;99;114;122;84;72;111 18:06:15 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;88;94;88;93;90;96;78;141;76;142 18:06:15 INFO - PROCESS | 1687 | |6;imaging-darkroom;96;97;97;96;94;104;144;96;97;95 18:06:15 INFO - PROCESS | 1687 | |7;imaging-desaturate;91;91;93;91;94;93;97;96;93;92 18:06:15 INFO - PROCESS | 1687 | |8;json-parse-financial;57;55;58;54;53;57;75;74;56;47 18:06:15 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;66;68;70;90;103;107;98;74;69;66 18:06:15 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;84;87;87;83;88;102;85;84;87;103 18:06:15 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;129;126;131;135;124;127;132;136;152;122 18:06:15 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;149;131;171;185;169;138;141;160;143;143 18:06:15 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;69;75;90;98;101;84;67;68;71;68 18:06:15 INFO - PROCESS | 1687 | __end_tp_report 18:06:15 INFO - PROCESS | 1687 | __start_cc_report 18:06:15 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,940 18:06:15 INFO - PROCESS | 1687 | __end_cc_report 18:06:15 INFO - PROCESS | 1687 | __startTimestamp1454983575720__endTimestamp 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | ------- Summary: start ------- 18:06:15 INFO - PROCESS | 1687 | Number of tests: 14 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:124.10 Median:132.00 stddev:21.76 (16.5%) stddev-sans-first:22.93 18:06:15 INFO - PROCESS | 1687 | Values: 117.0 109.0 116.0 113.0 116.0 129.0 143.0 92.0 135.0 171.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:156.50 stddev:15.27 (9.8%) stddev-sans-first:16.13 18:06:15 INFO - PROCESS | 1687 | Values: 152.0 146.0 138.0 182.0 155.0 170.0 133.0 156.0 172.0 157.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:201.50 Median:199.00 stddev:8.54 (4.3%) stddev-sans-first:8.34 18:06:15 INFO - PROCESS | 1687 | Values: 192.0 199.0 196.0 218.0 214.0 198.0 199.0 199.0 206.0 194.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:73.90 Median:62.50 stddev:21.44 (34.3%) stddev-sans-first:22.73 18:06:15 INFO - PROCESS | 1687 | Values: 76.0 72.0 70.0 110.0 58.0 56.0 64.0 61.0 115.0 57.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:77.00 stddev:19.58 (25.4%) stddev-sans-first:20.13 18:06:15 INFO - PROCESS | 1687 | Values: 82.0 82.0 119.0 72.0 99.0 114.0 122.0 84.0 72.0 111.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:98.60 Median:89.00 stddev:23.51 (26.4%) stddev-sans-first:24.62 18:06:15 INFO - PROCESS | 1687 | Values: 88.0 94.0 88.0 93.0 90.0 96.0 78.0 141.0 76.0 142.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:101.60 Median:96.00 stddev:15.14 (15.8%) stddev-sans-first:15.92 18:06:15 INFO - PROCESS | 1687 | Values: 96.0 97.0 97.0 96.0 94.0 104.0 144.0 96.0 97.0 95.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:93.10 Median:93.00 stddev:2.08 (2.2%) stddev-sans-first:2.06 18:06:15 INFO - PROCESS | 1687 | Values: 91.0 91.0 93.0 91.0 94.0 93.0 97.0 96.0 93.0 92.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.00 stddev:8.93 (15.7%) stddev-sans-first:9.46 18:06:15 INFO - PROCESS | 1687 | Values: 57.0 55.0 58.0 54.0 53.0 57.0 75.0 74.0 56.0 47.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:81.10 Median:69.50 stddev:16.54 (23.8%) stddev-sans-first:16.62 18:06:15 INFO - PROCESS | 1687 | Values: 66.0 68.0 70.0 90.0 103.0 107.0 98.0 74.0 69.0 66.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:86.00 stddev:7.30 (8.5%) stddev-sans-first:7.52 18:06:15 INFO - PROCESS | 1687 | Values: 84.0 87.0 87.0 83.0 88.0 102.0 85.0 84.0 87.0 103.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:131.50 stddev:8.54 (6.5%) stddev-sans-first:9.01 18:06:15 INFO - PROCESS | 1687 | Values: 129.0 126.0 131.0 135.0 124.0 127.0 132.0 136.0 152.0 122.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:154.50 stddev:17.39 (11.3%) stddev-sans-first:18.39 18:06:15 INFO - PROCESS | 1687 | Values: 149.0 131.0 171.0 185.0 169.0 138.0 141.0 160.0 143.0 143.0 18:06:15 INFO - PROCESS | 1687 | 18:06:15 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.10 Median:73.00 stddev:13.15 (18.0%) stddev-sans-first:13.43 18:06:15 INFO - PROCESS | 1687 | Values: 69.0 75.0 90.0 98.0 101.0 84.0 67.0 68.0 71.0 68.0 18:06:15 INFO - PROCESS | 1687 | -------- Summary: end -------- 18:06:15 INFO - PROCESS | 1687 | 18:06:16 INFO - TEST-INFO | 1687: exit 0 18:06:16 INFO - TEST-OK | kraken | took 58376ms 18:06:16 INFO - SUITE-END | took 1167s 18:06:16 INFO - Completed test suite (00:19:28) 18:06:16 INFO - Working with test: dromaeo_css 18:06:16 INFO - Generating results file: dromaeo_css 18:06:16 INFO - Working with test: kraken 18:06:16 INFO - Generating results file: kraken 18:06:16 INFO - javascript benchmark 18:06:16 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:06:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 18:06:16 INFO - process_Request line: dromaeo_css 7493.53 graph.html#tests=[[72,64,61]] 18:06:16 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:06:16 INFO - process_Request line: kraken 1536.80 graph.html#tests=[[232,64,61]] 18:06:16 INFO - RETURN: dromaeo_css: 7493.53 18:06:16 INFO - RETURN: kraken: 1536.80 18:06:16 INFO - javascript benchmark 18:06:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2911.3012876909534, 3088.382323535293, 3450.775699579527, 3496.6678165574262, 3527.4532447470633, 5582.748776305066, 5633.15502674599, 5636.549076073915, 5655.20827084208, 5674.744636491358, 5329.0, 5621.80323688671, 5646.604737668365, 5712.371639119693, 5822.068469044953, 5104.744762761866, 5142.27459446494, 5161.793528258865, 5166.199239117943, 5206.635535512516, 285.92052017880553, 4947.060058588874, 5083.313752643383, 5157.742112894359, 5167.896642067157, 5131.974340128276, 5132.332796736419, 5132.897342053138, 5137.588992880579, 5180.533751962323, 5147.897042059138, 5154.922676159823, 5169.069567477853, 5169.2504586835075, 5214.947850521522, 5016.372953380827, 5036.622253331015, 5131.461196574381, 5132.640715149941, 5142.871428214325, 4459.754713490756, 4480.865574032784, 4530.388397566319, 4576.0, 5319.441458646825, 6003.6397816131175, 6138.47822935051, 6180.6291622502795, 6198.3801619838105, 6225.252969643627, 5544.1960915667405, 5777.508911742507, 6149.0776383542825, 6150.200473938404, 6150.231221097363, 5711.543076553908, 5712.628679135884, 5725.398833122504, 5733.254676891977, 5741.540676745851, 6137.631742095488, 6139.631622102688, 6141.240538582634, 6192.349803270682, 6235.189425374672, 6065.60573562717, 6098.841220168242, 6112.299199283796, 6115.839196380484, 6142.0, 6099.786507472217, 6159.753609855646, 6172.9074063889075, 6175.44421002112, 6178.258608966953, 4913.828016019422, 6097.512199024156, 6143.692815359214, 6200.224971878515, 6237.812865613948, 6141.692915354304, 6227.501799856092, 6232.220972378453, 6242.313345531988, 6257.155284036688, 4796.856094317176, 4823.9517604824205, 4890.095332363524, 4891.119598472309, 4925.482824303468, 4282.186384586981, 4382.561743825656, 4400.845970391021, 4430.5126436092005, 4431.534688857688, 5594.468525490072, 5656.830295091071, 5697.686627235542, 5712.0, 5758.7696492140685, 6100.3086879273915, 6154.569180157436, 6254.530910181755, 6259.280182779039, 6259.3427690091885, 5730.255066841284, 5752.683602401824, 5753.683547404933, 5760.683162426107, 5773.913391299134, 5353.518183363516, 5359.276497672842, 5361.27622770921, 5392.379876314196, 5396.0, 5173.896522069537, 5695.572832037614, 6257.124002639634, 6268.905966410507, 6288.371162883766, 6221.844453888689, 6223.751049957951, 6246.031865060922, 6253.280872699698, 6266.843328916631, 6157.907631385443, 6166.876662466636, 6263.78076767311, 6302.212223472066, 6309.0, 5045.4450010498085, 5960.791372301948, 6046.969765151146, 6065.6663883486835, 6117.0, 6127.84680382994, 6168.475679567287, 6171.228596425447, 6179.104029915727, 6187.319394866471, 5070.569001634903, 5404.0, 6069.423404776539, 6131.1931684982055, 6155.876882462236, 4983.451820299837, 6046.818595442144, 6052.273727152769, 6107.083937409424, 6124.601900876429, 5713.314402271754, 5976.551758618208, 5992.250968628921, 6015.849603759766, 6041.667708276087, 5790.7973220937065, 5943.138244954544, 5982.790602328898, 5987.31145918225, 6038.184845045863, 5876.118582212703, 5906.497947674324, 5919.141724450017, 5928.170056192051, 5933.525317974465], "unit": "score", "name": "dojo.html", "value": 5541.157914602265}, {"lowerIsBetter": false, "replicates": [437.81392908014107, 467.54647991448303, 502.4949925325048, 561.977520899164, 576.9413126912116, 36614.901552953386, 36906.44640330397, 36989.81505092477, 37157.256854862884, 37216.25567488649, 38844.61155388445, 39153.80423097888, 39349.60650393495, 39423.802880985626, 39469.40795888057, 9417.85873211904, 9563.904360956405, 9611.663591774255, 9628.662996795114, 9631.470269135194, 7846.607669616525, 8763.868541971875, 9378.249740020816, 9481.194098501635, 9526.571304291288, 8264.83470330593, 9564.234861211087, 9650.372725772802, 9667.5649595768, 9711.417314961089, 9571.760705982337, 9628.229741620653, 9644.18024467921, 9647.083527064917, 9652.806943861084, 9675.0, 9778.07108324708, 9806.705798826046, 9810.46042467664, 9832.606695732162, 38679.8396048119, 38963.61036389628, 39070.02324941871, 39248.41127383091, 39352.803235983636, 2784.470950519395, 3230.2731885325848, 3280.4423248047888, 3452.723782097426, 3593.4250519916686, 27985.720142798516, 28444.146675599764, 28487.57855582278, 28626.0, 29301.41397172066, 2789.079603730764, 2794.147784925597, 2862.685104638488, 2862.799604027719, 2974.419988102321, 479826.0, 491661.0, 492809.0, 493206.0, 511681.9999999963, 69758.0, 71678.64160679268, 72231.6388418065, 72258.0, 72310.0, 70627.64686176536, 70779.6461017702, 71409.6429517849, 71576.0, 71871.28128718646, 16278.186090695655, 16586.75119873203, 16720.581985450463, 16768.748468772978, 16810.075445850594, 12747.36263186837, 13048.54330098442, 13141.54004609834, 13173.077884548182, 13223.73552528944, 22262.0, 22666.206682766024, 22700.091996320294, 22764.0, 22775.202867899545, 9705.223582113415, 9936.751581210383, 9989.250806189564, 10026.846912605144, 10033.598656053677, 897.6465232279533, 967.351874244258, 1089.3790539392471, 1090.3948308688596, 1141.6456817525777, 28673.426531469253, 28868.566971495446, 29059.854700726362, 29076.563851542243, 29324.0, 1052.0899422000068, 1129.9774004519863, 1139.316410153901, 1175.6002958993984, 1253.7116463213513, 15551.455699050704, 15732.92133539348, 15753.842461575467, 15861.365545378056, 16134.435294764628, 652938.0, 654825.0, 656454.0, 657319.0, 658780.0, 56861.715691422105, 57451.0, 57484.71257643685, 57811.42188578145, 58035.709821450626, 1459.5183589415467, 1468.9706205875823, 1481.659218379757, 1491.7240310542584, 1596.3933705192185, 28607.284817878888, 28881.075573845414, 28977.13068607945, 29597.5560366599, 29765.702342976292, 40291.395629065, 46444.6066618002, 47039.76480117578, 47042.52957470382, 47768.76115619539, 503276.0, 503933.0, 506261.0, 506495.0, 506866.0, 31429.214269643442, 41950.79024604857, 43171.78414107909, 43436.78281608572, 43488.56511434845, 47842.760786195846, 49695.0, 50396.0, 51172.48827511826, 51230.487695124066, 33143.83428082844, 37883.0, 38484.80757596194, 38712.80643596876, 39084.0, 37351.43972840355, 37926.62073379341, 38261.0, 39180.804095979336, 39247.0, 38800.611993880826, 39327.6067239324, 39381.0, 39455.408168876915, 40136.799316003235, 33046.66953330436, 34783.82608086943, 35280.823595881855, 36190.27619447544, 36245.0, 20996.448342228796, 22541.0, 24177.63733543963, 25212.62181067249, 26523.07169249067], "unit": "score", "name": "ext.html", "value": 20425.104318354992}, {"lowerIsBetter": false, "replicates": [359.5397890699905, 365.8573156468977, 367.2709671302464, 367.29479399552855, 371.22969837587016, 15132.546023619281, 18727.344542941, 18964.905175474138, 19188.616227675437, 19857.80853148812, 19084.33204837831, 19251.807481925178, 19553.902230488828, 19572.02139893007, 19585.412437626896, 4007.398890166484, 4581.518940511231, 5222.660527065738, 5462.0, 5797.5651826113, 5904.7342869570975, 5928.940710592882, 5967.40325967402, 5968.224130863004, 5979.551533634973, 5670.121131224667, 5765.596408251424, 5808.390119037504, 5938.0, 5941.762329506814, 5657.264555607765, 5840.970795146019, 5854.560907931922, 5893.5579831512805, 5955.225820643332, 5576.275084239063, 5622.634528755618, 5633.408492108351, 5644.6330988485615, 5668.922904648103, 12078.69803254917, 12579.496820127275, 12606.0, 12628.621141365773, 17300.48098557045, 2017.6368253714325, 2040.3980825656467, 2233.1960494222067, 2352.1649814315842, 2425.672534207895, 9464.242860571137, 9687.54686796986, 9767.51162441875, 9797.236497430531, 9828.655997040141, 1631.6899789040044, 1674.8073971493313, 1718.1237568839856, 1757.3058641836403, 1798.307651554148, 98795.86527247544, 104381.0, 104620.0, 105207.0, 105609.94390056079, 11215.158863085302, 11323.263987840928, 11345.886541134483, 11390.65828025144, 11439.59961401347, 13432.0, 13555.796663050061, 13569.914406847429, 13571.796423053662, 13600.775930166332, 7360.926390736131, 8502.532360720219, 8512.829743405096, 8553.914460855312, 8608.741737747752, 7017.89473157903, 8627.654893804303, 8639.78400539979, 8672.81335659108, 8688.91311086881, 3577.8908538353194, 4017.4375587417785, 4239.872803815891, 4357.281048627005, 4428.180786554498, 1859.674556952555, 1877.6995680691298, 1908.4370110817342, 1942.931997380085, 1943.3295513047976, 855.3584811391456, 865.4201684871151, 1038.0916697889347, 1050.0392141190725, 1051.7859904900229, 18083.909580452015, 19010.80989190118, 19179.712304315446, 19485.610287794163, 19635.0, 888.5335199020566, 925.4031149908271, 932.1331162019387, 935.1116439382478, 1022.2486472442748, 9865.901340986498, 9897.802043959224, 10675.83986240207, 11049.33703977764, 11211.327320360804, 697709.0, 711839.0, 713685.0, 720803.0, 725935.0, 67791.0, 87044.0, 102170.48914755379, 107889.0, 113016.0, 1179.7404570994368, 1181.0610564601163, 1183.923045002072, 1218.2812140836772, 1222.914395992272, 13473.595792126252, 17601.82398176002, 17740.93554386741, 17917.64164716672, 18070.367537136663, 45030.77484612556, 47625.0, 49196.0, 49315.50684493109, 50426.478676065315, 62526.74946500953, 67158.65682686417, 67971.66014169897, 68232.97650535147, 68696.0, 5725.2843394575675, 7440.0, 7596.772096837104, 7656.770296891103, 7711.691532338644, 10923.508442119964, 11388.145889058189, 11866.347350895783, 11883.881161188277, 12141.392930353624, 3755.9812200938823, 3837.0791010156804, 8568.785780355542, 10085.125739164303, 10508.159347252355, 9449.763755906157, 10171.881093079608, 10288.331258468475, 10333.586656533955, 10460.26778125524, 10367.0151335623, 10444.321119127233, 10603.764773681385, 10729.195310351912, 10742.946285268523, 6266.467350275278, 7480.92519074824, 7599.278068583476, 7624.199459056719, 7705.730299439493, 7332.596707180943, 10232.0, 10307.690769276935, 10367.896321036995, 10368.844467333147], "unit": "score", "name": "jquery.html", "value": 8855.392847237827}, {"lowerIsBetter": false, "replicates": [1542.753159494481, 1548.6360705234272, 1781.8129096444873, 1874.2784028149167, 1899.9240030398785, 7856.489328193664, 8526.445781024244, 8575.0, 8765.912340876597, 8883.02286748458, 7750.573718445483, 8007.879881801763, 8561.48631082134, 8670.393072484929, 8670.52312122833, 2457.901683932645, 2457.9754202457925, 2460.790832779216, 2461.4461746107163, 2473.319837044809, 2028.5435776950142, 2400.6519054737055, 2440.7559244075537, 2440.9511809763794, 2443.7067551893797, 2003.6994450832347, 2190.463336482564, 2421.140495124232, 2443.0105807148134, 2488.191337815208, 2016.5462770876509, 2395.197608801054, 2446.7675570820743, 2475.665785119013, 2483.3170878008514, 2290.7022087128735, 2372.181597348912, 2387.248016874679, 2393.940151496209, 2413.613821788523, 6441.871162576722, 7614.505057171266, 8044.034715834137, 8567.528785916773, 8612.52631105289, 5156.020356132361, 5315.734213289359, 5410.0, 5504.146857237135, 5504.752286147133, 3278.6885245901603, 3625.365561026836, 3700.8704695335805, 3736.953652977171, 3753.080495278647, 911.9908800912038, 1059.1050562274866, 1071.9249652524327, 1093.6882988348361, 1094.895984881435, 11835.763284734343, 11947.0, 11959.461824217844, 11969.581064662782, 11974.0, 4862.954464790017, 4913.680610760289, 4923.532264434873, 4962.478939711351, 5011.649184557046, 9955.104040636377, 10257.538410771533, 10257.692269231935, 10282.742931426774, 10312.071913527818, 5450.5639548836, 5452.127659574449, 5469.042917489423, 5471.069918113851, 5480.671159730429, 4879.072976134594, 4945.851624451272, 4984.526469985346, 4994.2508623706735, 5001.024800163933, 3438.8108654023767, 3899.8885317684326, 3911.7457365271166, 3939.5863434339553, 3951.8024098794945, 1226.8405107335989, 1311.9737605248033, 1312.2126723965544, 1316.6379245707508, 1322.510671051717, 1080.3247970018738, 1099.8790133085354, 1109.0850048709847, 1249.631358749171, 1357.0, 7823.56970366624, 7901.802454938557, 7959.562224077731, 7972.481788683717, 7994.760157195294, 1025.5795123999123, 1178.1458442629025, 1178.3460179600404, 1183.2959389163434, 1196.0551164580058, 6052.515798736179, 6107.511399088063, 6141.631502109888, 6157.568970172135, 6232.0, 10154.390736555682, 10635.627753028606, 10672.039516443401, 10767.515461804081, 10785.46072696362, 10315.484225788681, 10545.209109316833, 10582.417967011888, 10602.151827853753, 10702.625408110678, 8257.174282571696, 8272.131426200283, 8291.08798032228, 8308.626111824982, 8416.0, 7698.384129269533, 7788.0, 7790.9220907790195, 7814.960925195338, 7836.764897053097, 7339.522931009467, 9451.385659932082, 9557.569909353957, 9570.56932438028, 9650.034996500293, 7964.840703185788, 9318.02160773109, 9584.37701549397, 9689.12797848197, 9724.95137524308, 7337.229590892879, 7439.55362678241, 7442.255774422514, 7488.288612581796, 7491.70033198666, 7915.1293357729455, 8045.07481639619, 8118.066422361504, 8124.67501299965, 8182.83634327322, 6993.370596646327, 7723.652435640522, 7810.453268271166, 7888.881666774888, 8051.919480805352, 7489.962550187214, 7502.287282708352, 7514.549127052394, 7614.961925190339, 7629.618519074135, 7641.617919103911, 7717.382609391348, 7761.456698031084, 7773.805654858674, 7780.260875216845, 6878.243393226641, 6921.996310534843, 6946.548474349152, 6953.165620125617, 6976.511644185061, 6066.848328791639, 6294.339094395205, 6503.122078519528, 6956.060931774348, 7010.719571217298], "unit": "score", "name": "mootools.html", "value": 4877.0460816108}, {"lowerIsBetter": false, "replicates": [276.64451180233397, 325.6645654975375, 329.41364371418865, 336.3239887825473, 338.4652249445874, 5399.433059528752, 6720.5295629305965, 6844.247132815392, 6983.952407138925, 6989.064592870994, 6803.829904252396, 6886.0703804986315, 6899.4135498482565, 6945.652717364124, 6967.338102880219, 4657.464391594976, 5037.748112594374, 5116.923246151292, 5117.769700363493, 5123.5388815006645, 4210.347396153586, 4367.908022994251, 5117.974410127944, 5125.589952803767, 5145.459726728677, 3946.3883098119836, 4281.871543853689, 4695.178343789823, 5025.597952163818, 5027.0, 5028.396592408898, 5033.119204139261, 5034.09386310464, 5040.521150490697, 5045.394552653668, 4083.081306705997, 4169.082801783603, 4251.107267473834, 4319.784010799447, 4340.001799586113, 6508.934910650928, 6513.902291465632, 6521.510886683518, 6561.376669216417, 6581.835454113638, 5421.756020979065, 5502.394736578973, 5994.700264986734, 6023.006203976339, 6027.7287522061615, 6753.425958793459, 6911.686779511877, 7370.963145184293, 7387.7783666490095, 7411.407087432993, 3947.50656167979, 4848.030393921194, 4853.878653033667, 4859.07677541266, 4870.975645121787, 7831.960840195819, 7834.0, 7844.137144914055, 7852.882206766903, 7882.960585197095, 4809.350737650442, 4912.164931961575, 4922.409310882717, 4929.644347804382, 4941.0, 5029.270755740397, 5044.1677123274985, 5047.369078865142, 5048.5203905628905, 5063.87340316495, 5266.710330931835, 5640.125780504029, 5990.101484777231, 5991.400859913973, 6014.51883849291, 6799.5920244785475, 6878.661087866109, 7417.8145546361775, 7455.329020388191, 7468.21583733711, 1407.3737186951912, 1755.1750677181703, 1756.6223261998475, 1757.5254681235995, 1759.780027496563, 1127.1095834290818, 1133.7052366384635, 1136.8067428537167, 1141.4007645985757, 1149.7815415071277, 6672.9656903180085, 6876.381125698711, 6876.931230687729, 6885.173779146434, 6903.068085808452, 6519.576227545194, 7759.495632783851, 7767.300942915164, 7767.53394796314, 7771.572563508948, 6692.18494552082, 6844.007618895332, 6860.176778786477, 6892.276310987374, 6892.689828957608, 3200.5839240898536, 4020.778857162884, 4069.877903662895, 4070.043539768152, 4157.043879907577, 6411.871762564816, 7046.449781048162, 7416.851662966818, 8005.719799806979, 8128.59357032146, 6756.459483241329, 7745.760678291446, 8019.478733882279, 8039.638216280281, 8084.3936704747375, 6963.850964590988, 7884.763457096296, 8122.7157049502985, 8233.053198882206, 8239.340852731768, 7693.230676932262, 7905.920940790518, 7912.129665736879, 7915.129335773176, 7990.121086680577, 7479.0, 7729.729459468892, 7730.613469326624, 7731.690732370642, 7735.845283094419, 8172.5913704315735, 8176.550289734122, 8188.344932405513, 8193.67225310981, 8262.380321475794, 4813.711177329372, 4858.319835223142, 4858.44127925279, 4863.270509423473, 4877.487863774252, 5873.442023007808, 6097.75608975636, 7806.453548251568, 7845.333146682596, 7857.842843143219, 6097.451229389376, 7556.093268807558, 7574.204708505527, 7580.507267027626, 7583.696652133853, 6228.785386849521, 7465.216152303929, 7533.547987120571, 7540.434467415075, 7554.093508778982, 7153.821154470972, 7389.261073892568, 7390.895823753929, 7396.890466430079, 7397.630118494161, 7535.13345965221, 7545.7358992435, 7547.849043019219, 7573.810654733676, 7584.924150758642, 7220.3140701633265, 7303.744368947061, 7356.852862942818, 7357.632118393952, 7389.8152546186775], "unit": "score", "name": "prototype.html", "value": 5339.396386074128}, {"lowerIsBetter": false, "replicates": [639.6801599200397, 640.5516138702909, 641.2433328672167, 682.7576210445292, 705.7106586299618, 14948.551543453701, 14953.0, 14983.175925324103, 15257.465988690397, 15283.694326113471, 13747.793783093262, 13779.44882204713, 13799.2410417427, 13811.861881381183, 13813.930930345334, 671.983200419991, 823.7775800533882, 837.673307410109, 842.5492361586553, 853.9837593264027, 698.0088274650009, 734.9044624198847, 841.0412130171609, 844.6536919862857, 855.2559273432123, 884.3455842676406, 885.8316919785252, 893.4728510178993, 897.1611543207122, 897.4525539420948, 870.8127752533236, 879.3404946290283, 889.3863234368298, 891.1534042659499, 892.0187793427243, 652.9738810447576, 656.1109696361457, 658.3975662269019, 666.5833853841349, 667.7796327212056, 14477.710445791025, 14816.259187040605, 14888.404463821542, 14905.850941490555, 15007.474738384104, 10498.0, 12499.437525311383, 12576.81134782979, 12861.742765144645, 13537.766684495218, 10190.59237630494, 10198.694039178836, 10218.9489052555, 10228.232882533839, 10238.53926573306, 3493.6506349365113, 3507.754457187998, 3525.048236976002, 3528.2943411317838, 3531.470279458076, 73134.26865731328, 73966.26033739648, 74245.0, 74645.62677186633, 85054.0, 9382.906170938204, 9507.857382139273, 9557.187639050759, 9643.373180743229, 9658.082482164184, 19906.90046549758, 20049.59900802005, 20070.89964550168, 20074.096665650082, 20107.798922010887, 7328.633568321563, 7496.400287976949, 7537.623118844036, 7716.382689384835, 7763.495372800863, 4161.0637606538285, 4181.707280490336, 4220.240356735756, 4233.809478573472, 4247.384129301234, 3530.2057037166433, 3575.6424357564038, 3581.4806853006166, 3585.659362360572, 3594.982025089858, 550.3615805665409, 647.3170804800886, 650.0, 654.2900952466532, 678.494521581425, 544.4337888595816, 583.3961849485762, 594.3610618584952, 610.9725062372204, 635.9665543491826, 8359.665613375519, 8617.82764344722, 8691.004276065909, 8692.478451292816, 8710.738677839676, 518.8210067526697, 578.9826305210767, 599.349705569462, 602.3584882100549, 613.6471528870917, 3901.3757798752063, 4338.978305108454, 4368.781560922005, 4379.211741886427, 4397.40635014269, 63220.68389658114, 81125.16061937803, 85420.57289713636, 85541.0, 85655.57172214099, 73379.63310183414, 73972.26027739761, 74696.0, 74989.0, 75159.24840751632, 65700.3574910631, 66777.33222667809, 66928.66535667291, 66946.33053669498, 67657.98513022308, 6934.618595977068, 7511.0, 8720.43317184381, 8800.0, 8937.776555585902, 45136.322955156356, 47641.761791190824, 47973.280400793315, 48013.0, 48087.75956120337, 67435.66282168558, 67529.3247067523, 67543.97368078966, 68008.0, 68425.3157468419, 11144.721381965515, 11158.832617510907, 11325.71685707864, 11490.138239631893, 12039.75920481603, 9463.0, 9783.902160978583, 11942.70143246391, 13251.602451926457, 13270.1374410663, 11039.227254092137, 11903.642890713292, 12055.879441205476, 12063.336516491678, 12272.443656874877, 11466.31202127875, 11641.41792910368, 11667.708307292385, 11931.164818462625, 12390.62828115158, 11409.942950285196, 11471.541138354372, 11725.530978760755, 11827.231229970024, 12393.132480726263, 9044.592993315448, 9339.859902101338, 9412.435253884789, 9581.664641737505, 10071.848922266025, 9230.662627942418, 9271.773451679524, 9531.761705957406, 9926.205903527845, 10001.799964000533], "unit": "score", "name": "yui.html", "value": 6783.63549801108}], "name": "dromaeo_css", "value": 7493.5323359673575}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 109.0, 116.0, 113.0, 116.0, 129.0, 143.0, 92.0, 135.0, 171.0], "unit": "score", "name": "ai-astar", "value": 124.1}, {"lowerIsBetter": true, "replicates": [152.0, 146.0, 138.0, 182.0, 155.0, 170.0, 133.0, 156.0, 172.0, 157.0], "unit": "score", "name": "audio-beat-detection", "value": 156.1}, {"lowerIsBetter": true, "replicates": [192.0, 199.0, 196.0, 218.0, 214.0, 198.0, 199.0, 199.0, 206.0, 194.0], "unit": "score", "name": "audio-dft", "value": 201.5}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 70.0, 110.0, 58.0, 56.0, 64.0, 61.0, 115.0, 57.0], "unit": "score", "name": "audio-fft", "value": 73.9}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 119.0, 72.0, 99.0, 114.0, 122.0, 84.0, 72.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 95.7}, {"lowerIsBetter": true, "replicates": [88.0, 94.0, 88.0, 93.0, 90.0, 96.0, 78.0, 141.0, 76.0, 142.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 94.0, 104.0, 144.0, 96.0, 97.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 101.6}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 93.0, 91.0, 94.0, 93.0, 97.0, 96.0, 93.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 93.1}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 58.0, 54.0, 53.0, 57.0, 75.0, 74.0, 56.0, 47.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 70.0, 90.0, 103.0, 107.0, 98.0, 74.0, 69.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.1}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 87.0, 83.0, 88.0, 102.0, 85.0, 84.0, 87.0, 103.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.0}, {"lowerIsBetter": true, "replicates": [129.0, 126.0, 131.0, 135.0, 124.0, 127.0, 132.0, 136.0, 152.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.4}, {"lowerIsBetter": true, "replicates": [149.0, 131.0, 171.0, 185.0, 169.0, 138.0, 141.0, 160.0, 143.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.0}, {"lowerIsBetter": true, "replicates": [69.0, 75.0, 90.0, 98.0, 101.0, 84.0, 67.0, 68.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 79.1}], "name": "kraken", "value": 1536.8000000000002}]} 18:06:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1536.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7493.53"}}} 18:06:17 INFO - Return code: 0 18:06:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:06:17 INFO - # TBPL SUCCESS # 18:06:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:06:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:06:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:06:17 INFO - 2016-02-08 18:06:17.114 screenresolution[1692:10406] starting screenresolution argv=screenresolution get 18:06:17 INFO - 2016-02-08 18:06:17.117 screenresolution[1692:10406] Display 0: 1600x1200x32@60 18:06:17 INFO - 2016-02-08 18:06:17.122 screenresolution[1693:10409] starting screenresolution argv=screenresolution list 18:06:17 INFO - Available Modes on Display 0 18:06:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:06:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:06:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:06:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:06:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:06:17 INFO - Intel Iris: 18:06:17 INFO - Chipset Model: Intel Iris 18:06:17 INFO - Type: GPU 18:06:17 INFO - Bus: Built-In 18:06:17 INFO - VRAM (Dynamic, Max): 1536 MB 18:06:17 INFO - Vendor: Intel (0x8086) 18:06:17 INFO - Device ID: 0x0a2e 18:06:17 INFO - Revision ID: 0x0009 18:06:17 INFO - Displays: 18:06:17 INFO - Display: 18:06:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:06:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:06:17 INFO - Display Serial Number: 1600x1200 60 18:06:17 INFO - Main Display: Yes 18:06:17 INFO - Mirror: Off 18:06:17 INFO - Online: Yes 18:06:17 INFO - Rotation: Supported 18:06:17 INFO - Return code: 0 18:06:17 INFO - Running post-action listener: _resource_record_post_action 18:06:17 INFO - Running post-run listener: _resource_record_post_run 18:06:18 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 39212544; Write bytes: 712270336; Read time: 443; Write time: 1974 18:06:18 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 397496832; Write bytes: 391546368; Read time: 30224; Write time: 696 18:06:18 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 37385728; Write bytes: 302943232; Read time: 422; Write time: 1236 18:06:18 INFO - Running post-run listener: _upload_blobber_files 18:06:18 INFO - Blob upload gear active. 18:06:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:06:18 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 18:06:18 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'] 18:06:18 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 18:06:18 INFO - (blobuploader) - INFO - Open directory for files ... 18:06:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:06:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:06:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:06:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:06:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:06:20 INFO - (blobuploader) - INFO - Done attempting. 18:06:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:06:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:06:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:06:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:06:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:06:21 INFO - (blobuploader) - INFO - Done attempting. 18:06:21 INFO - (blobuploader) - INFO - Iteration through files over. 18:06:21 INFO - Return code: 0 18:06:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:06:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:06:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd06031c0e7cca3567b0ed2f495851dc23843e83db0a3705411195d4afb87731b9caa1a36138c9a6b77aa8748a8e08ed4d4d383ff1ea3f053b5a94c4a130d6d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/955a58667a793f4b8a1259108ddca07a5235112504e8d7023d45a472a27263db89c1b8ad0fae92759011c2611c66065e3add0bebcb5d30c5a83325a7fbfa4450"} 18:06:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:06:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:06:21 INFO - Contents: 18:06:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd06031c0e7cca3567b0ed2f495851dc23843e83db0a3705411195d4afb87731b9caa1a36138c9a6b77aa8748a8e08ed4d4d383ff1ea3f053b5a94c4a130d6d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/955a58667a793f4b8a1259108ddca07a5235112504e8d7023d45a472a27263db89c1b8ad0fae92759011c2611c66065e3add0bebcb5d30c5a83325a7fbfa4450"} 18:06:21 INFO - Running post-run listener: copy_logs_to_upload_dir 18:06:21 INFO - Copying logs to upload dir... 18:06:21 INFO - mkdir: /builds/slave/test/build/upload/logs 18:06:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.591355 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-02-08 18:06:21.375718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-02-08 18:06:21.379234) ========= 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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd06031c0e7cca3567b0ed2f495851dc23843e83db0a3705411195d4afb87731b9caa1a36138c9a6b77aa8748a8e08ed4d4d383ff1ea3f053b5a94c4a130d6d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/955a58667a793f4b8a1259108ddca07a5235112504e8d7023d45a472a27263db89c1b8ad0fae92759011c2611c66065e3add0bebcb5d30c5a83325a7fbfa4450"} build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd06031c0e7cca3567b0ed2f495851dc23843e83db0a3705411195d4afb87731b9caa1a36138c9a6b77aa8748a8e08ed4d4d383ff1ea3f053b5a94c4a130d6d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/955a58667a793f4b8a1259108ddca07a5235112504e8d7023d45a472a27263db89c1b8ad0fae92759011c2611c66065e3add0bebcb5d30c5a83325a7fbfa4450"}' ========= master_lag: 2.65 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-02-08 18:06:24.044599) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-02-08 18:06:24.044964) ========= 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.5z00Ma2NOn/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.fPm8aPzOIJ/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005219 ========= master_lag: 4.32 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-02-08 18:06:28.373394) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-02-08 18:06:28.374170) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-02-08 18:06:29.657034) ========= ========= Total master_lag: 9.81 =========