builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0120 starttime: 1458690768.26 results: success (0) buildid: 20160322142325 builduid: 6fadd3eae876481d9edc5e54f9a9a29a revision: abfac0d05b79b49597d5fa8d4ce87caf4caaff8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 16:52:48.259916) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 16:52:48.260325) ========= ========= Started set props: basedir (results: 0, elapsed: 11 secs) (at 2016-03-22 16:52:48.260623) ========= 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.mC139zXAHg/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.IyBriXwBpB/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.005685 basedir: '/builds/slave/test' ========= master_lag: 11.56 ========= ========= Finished set props: basedir (results: 0, elapsed: 11 secs) (at 2016-03-22 16:52:59.825118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 12 secs) (at 2016-03-22 16:52:59.825462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 12 secs) (at 2016-03-22 16:53:12.823756) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 16:53:12.824100) ========= 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.mC139zXAHg/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.IyBriXwBpB/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.005775 ========= master_lag: 0.84 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 16:53:13.665515) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 16:53:13.665811) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 16:53:13.666155) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-22 16:53:13.666436) ========= 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.mC139zXAHg/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.IyBriXwBpB/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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-03-22 16:53:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 47.1M=0s 2016-03-22 16:53:13 (47.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163861 ========= master_lag: 0.90 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-22 16:53:14.728872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-22 16:53:14.729165) ========= 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.mC139zXAHg/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.IyBriXwBpB/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.026181 ========= master_lag: 1.45 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-22 16:53:16.203914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-22 16:53:16.204274) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev abfac0d05b79b49597d5fa8d4ce87caf4caaff8e --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 abfac0d05b79b49597d5fa8d4ce87caf4caaff8e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mC139zXAHg/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.IyBriXwBpB/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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-03-22 16:53:16,822 truncating revision to first 12 chars 2016-03-22 16:53:16,823 Setting DEBUG logging. 2016-03-22 16:53:16,823 attempt 1/10 2016-03-22 16:53:16,823 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/abfac0d05b79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-22 16:53:17,477 unpacking tar archive at: fx-team-abfac0d05b79/testing/mozharness/ program finished with exit code 0 elapsedTime=0.892273 ========= master_lag: 1.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-22 16:53:18.304152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 16:53:18.304503) ========= echo abfac0d05b79b49597d5fa8d4ce87caf4caaff8e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'abfac0d05b79b49597d5fa8d4ce87caf4caaff8e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mC139zXAHg/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.IyBriXwBpB/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 abfac0d05b79b49597d5fa8d4ce87caf4caaff8e program finished with exit code 0 elapsedTime=0.005896 script_repo_revision: 'abfac0d05b79b49597d5fa8d4ce87caf4caaff8e' ========= master_lag: 0.83 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 16:53:19.142249) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-03-22 16:53:19.142538) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-03-22 16:53:20.277680) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-03-22 16:53:20.277934) ========= /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.mC139zXAHg/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.IyBriXwBpB/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 16:53:20 INFO - MultiFileLogger online at 20160322 16:53:20 in /builds/slave/test 16:53:20 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 16:53:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:53:20 INFO - {'append_to_log': False, 16:53:20 INFO - 'base_work_dir': '/builds/slave/test', 16:53:20 INFO - 'blob_upload_branch': 'Fx-Team', 16:53:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:53:20 INFO - 'branch': 'Fx-Team', 16:53:20 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:20 INFO - 'config_files': ('talos/mac_config.py',), 16:53:20 INFO - 'default_actions': ('clobber', 16:53:20 INFO - 'read-buildbot-config', 16:53:20 INFO - 'download-and-extract', 16:53:20 INFO - 'populate-webroot', 16:53:20 INFO - 'create-virtualenv', 16:53:20 INFO - 'install', 16:53:20 INFO - 'run-tests'), 16:53:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:20 INFO - 'download_minidump_stackwalk': True, 16:53:20 INFO - 'download_symbols': 'ondemand', 16:53:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:53:20 INFO - 'tooltool.py': '/tools/tooltool.py', 16:53:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:53:20 INFO - '/tools/misc-python/virtualenv.py')}, 16:53:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:20 INFO - 'installer_path': 'installer.exe', 16:53:20 INFO - 'log_level': 'info', 16:53:20 INFO - 'log_name': 'talos', 16:53:20 INFO - 'log_to_console': True, 16:53:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:53:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:53:20 INFO - 'opt_config_files': (), 16:53:20 INFO - 'pip_index': False, 16:53:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:53:20 INFO - 'cmd': ('bash', 16:53:20 INFO - '-c', 16:53:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:53:20 INFO - 'enabled': True, 16:53:20 INFO - 'halt_on_failure': False, 16:53:20 INFO - 'name': 'check_screen_resolution'},), 16:53:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:53:20 INFO - 'cmd': ('bash', 16:53:20 INFO - '-c', 16:53:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:53:20 INFO - 'enabled': True, 16:53:20 INFO - 'halt_on_failure': False, 16:53:20 INFO - 'name': 'check_screen_resolution'},), 16:53:20 INFO - 'run_cmd_checks_enabled': True, 16:53:20 INFO - 'sps_profile': False, 16:53:20 INFO - 'sps_profile_interval': 0, 16:53:20 INFO - 'suite': 'dromaeojs-e10s', 16:53:20 INFO - 'system_bits': '32', 16:53:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:20 INFO - 'title': 't-yosemite-r7-0120', 16:53:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:20 INFO - 'use_talos_json': True, 16:53:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:53:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:20 INFO - 'work_dir': 'build'} 16:53:20 INFO - ##### 16:53:20 INFO - ##### Running clobber step. 16:53:20 INFO - ##### 16:53:20 INFO - Running pre-action listener: _resource_record_pre_action 16:53:20 INFO - Running main action method: clobber 16:53:20 INFO - rmtree: /builds/slave/test/build 16:53:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:53:23 INFO - Running post-action listener: _resource_record_post_action 16:53:23 INFO - ##### 16:53:23 INFO - ##### Running read-buildbot-config step. 16:53:23 INFO - ##### 16:53:23 INFO - Running pre-action listener: _resource_record_pre_action 16:53:23 INFO - Running main action method: read_buildbot_config 16:53:23 INFO - Using buildbot properties: 16:53:23 INFO - { 16:53:23 INFO - "project": "", 16:53:23 INFO - "product": "firefox", 16:53:23 INFO - "script_repo_revision": "production", 16:53:23 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:53:23 INFO - "repository": "", 16:53:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:53:23 INFO - "buildid": "20160322142325", 16:53:23 INFO - "pgo_build": "False", 16:53:23 INFO - "basedir": "/builds/slave/test", 16:53:23 INFO - "buildnumber": 632, 16:53:23 INFO - "slavename": "t-yosemite-r7-0120", 16:53:23 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:53:23 INFO - "platform": "yosemite_r7", 16:53:23 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 16:53:23 INFO - "branch": "fx-team", 16:53:23 INFO - "repo_path": "integration/fx-team", 16:53:23 INFO - "revision": "abfac0d05b79b49597d5fa8d4ce87caf4caaff8e", 16:53:23 INFO - "stage_platform": "macosx64", 16:53:23 INFO - "builduid": "6fadd3eae876481d9edc5e54f9a9a29a", 16:53:23 INFO - "slavebuilddir": "test" 16:53:23 INFO - } 16:53:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 16:53:23 INFO - Running post-action listener: _resource_record_post_action 16:53:23 INFO - ##### 16:53:23 INFO - ##### Running download-and-extract step. 16:53:23 INFO - ##### 16:53:23 INFO - Running pre-action listener: _resource_record_pre_action 16:53:23 INFO - Running main action method: download_and_extract 16:53:23 INFO - mkdir: /builds/slave/test/build/tests 16:53: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')]} 16:53:23 INFO - https://queue.taskcluster.net/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 16:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 16:53:24 INFO - Downloaded 1199 bytes. 16:53:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 16:53:24 INFO - Using the following test package requirements: 16:53:24 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:53:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:53:24 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 16:53:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:53:24 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 16:53:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:53:24 INFO - u'jsshell-mac.zip'], 16:53:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:53:24 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 16:53:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:53:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:53:24 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 16:53:24 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:53:24 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 16:53:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:53:24 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 16:53:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:53:24 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 16:53:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:53:24 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')]} 16:53:24 INFO - https://queue.taskcluster.net/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:53:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:53:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:53:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:53:26 INFO - Downloaded 17860527 bytes. 16:53:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:53:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:53:29 INFO - Return code: 0 16:53:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:53: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')]} 16:53:29 INFO - https://queue.taskcluster.net/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:53:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:53:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:53:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:53:31 INFO - Downloaded 17860527 bytes. 16:53:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:53:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:53:34 INFO - Return code: 0 16:53: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')]} 16:53:34 INFO - https://queue.taskcluster.net/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:53:36 INFO - Downloaded 10848120 bytes. 16:53:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:53:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:53:36 INFO - Return code: 0 16:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:36 INFO - https://queue.taskcluster.net/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:53:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:53:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:53:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 16:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 16:53:40 INFO - Downloaded 111272724 bytes. 16:53:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:53:40 INFO - mkdir: /builds/slave/test/properties 16:53:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:53:40 INFO - Writing to file /builds/slave/test/properties/build_url 16:53:40 INFO - Contents: 16:53:40 INFO - build_url:https://queue.taskcluster.net/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:53:41 INFO - Running post-action listener: _resource_record_post_action 16:53:41 INFO - Running post-action listener: set_extra_try_arguments 16:53:41 INFO - ##### 16:53:41 INFO - ##### Running populate-webroot step. 16:53:41 INFO - ##### 16:53:41 INFO - Running pre-action listener: _resource_record_pre_action 16:53:41 INFO - Running main action method: populate_webroot 16:53:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:53:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:53:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:53:41 INFO - '--tppagecycles', 16:53:41 INFO - '7'], 16:53:41 INFO - 'tests': ['tsvgm']}}, 16:53:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:53:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:53:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:53:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:53:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'tests': ['damp', 'tps']}, 16:53:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['damp', 'tps']}, 16:53:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:53:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:53:41 INFO - 'other': {'tests': ['a11yr', 16:53:41 INFO - 'ts_paint', 16:53:41 INFO - 'tpaint', 16:53:41 INFO - 'sessionrestore', 16:53:41 INFO - 'sessionrestore_no_auto_restore', 16:53:41 INFO - 'tabpaint']}, 16:53:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['a11yr', 16:53:41 INFO - 'ts_paint', 16:53:41 INFO - 'tpaint', 16:53:41 INFO - 'sessionrestore', 16:53:41 INFO - 'sessionrestore_no_auto_restore', 16:53:41 INFO - 'tabpaint']}, 16:53:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['a11yr', 16:53:41 INFO - 'ts_paint', 16:53:41 INFO - 'tpaint', 16:53:41 INFO - 'sessionrestore', 16:53:41 INFO - 'sessionrestore_no_auto_restore', 16:53:41 INFO - 'tabpaint']}, 16:53:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['a11yr', 16:53:41 INFO - 'ts_paint', 16:53:41 INFO - 'tpaint', 16:53:41 INFO - 'sessionrestore', 16:53:41 INFO - 'sessionrestore_no_auto_restore', 16:53:41 INFO - 'tabpaint']}, 16:53:41 INFO - 'other_l64': {'tests': ['a11yr', 16:53:41 INFO - 'ts_paint', 16:53:41 INFO - 'tpaint', 16:53:41 INFO - 'sessionrestore', 16:53:41 INFO - 'sessionrestore_no_auto_restore', 16:53:41 INFO - 'tabpaint']}, 16:53:41 INFO - 'other_nol64': {'tests': ['a11yr', 16:53:41 INFO - 'ts_paint', 16:53:41 INFO - 'tpaint', 16:53:41 INFO - 'sessionrestore', 16:53:41 INFO - 'sessionrestore_no_auto_restore', 16:53:41 INFO - 'tabpaint']}, 16:53:41 INFO - 'svgr': {'tests': ['tsvgx', 16:53:41 INFO - 'tsvgr_opacity', 16:53:41 INFO - 'tart', 16:53:41 INFO - 'tscrollx', 16:53:41 INFO - 'cart']}, 16:53:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['tsvgx', 16:53:41 INFO - 'tsvgr_opacity', 16:53:41 INFO - 'tart', 16:53:41 INFO - 'tscrollx', 16:53:41 INFO - 'cart']}, 16:53:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'tests': ['tp5o']}, 16:53:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'talos_options': ['--e10s'], 16:53:41 INFO - 'tests': ['tp5o']}, 16:53:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'talos_options': ['--xperf_path', 16:53:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:41 INFO - 'tests': ['tp5n']}, 16:53:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:41 INFO - 'talos_options': ['--e10s', 16:53:41 INFO - '--xperf_path', 16:53:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:41 INFO - 'tests': ['tp5n']}}, 16:53:41 INFO - 'talos.zip': {'path': '', 16:53:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:53:41 INFO - Running post-action listener: _resource_record_post_action 16:53:41 INFO - ##### 16:53:41 INFO - ##### Running create-virtualenv step. 16:53:41 INFO - ##### 16:53:41 INFO - Running pre-action listener: _resource_record_pre_action 16:53:41 INFO - Running main action method: create_virtualenv 16:53:41 INFO - Creating virtualenv /builds/slave/test/build/venv 16:53:41 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 16:53:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:53:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:53:41 INFO - Using real prefix '/tools/python27' 16:53:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:53:42 INFO - Installing distribute.............................................................................................................................................................................................done. 16:53:45 INFO - Installing pip.................done. 16:53:45 INFO - Return code: 0 16:53:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103577a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103587420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc688d891b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103416e00>, '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 0x10327fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103411b20>, '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.mC139zXAHg/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.IyBriXwBpB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 16:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:53:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC139zXAHg/Render', 16:53:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:45 INFO - 'HOME': '/Users/cltbld', 16:53:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:45 INFO - 'LOGNAME': 'cltbld', 16:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:45 INFO - 'MOZ_NO_REMOTE': '1', 16:53:45 INFO - 'NO_EM_RESTART': '1', 16:53:45 INFO - 'PAGER': '/bin/cat', 16:53:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:45 INFO - 'PWD': '/builds/slave/test', 16:53:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:45 INFO - 'SHELL': '/bin/bash', 16:53:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IyBriXwBpB/Listeners', 16:53:45 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 16:53:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:45 INFO - 'USER': 'cltbld', 16:53:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:45 INFO - 'XPC_FLAGS': '0x0', 16:53:45 INFO - 'XPC_SERVICE_NAME': '0', 16:53:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:45 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 16:53:45 INFO - Cleaning up... 16:53:45 INFO - Return code: 0 16:53:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103577a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103587420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc688d891b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103416e00>, '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 0x10327fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103411b20>, '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.mC139zXAHg/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.IyBriXwBpB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 16:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:53:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC139zXAHg/Render', 16:53:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:45 INFO - 'HOME': '/Users/cltbld', 16:53:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:45 INFO - 'LOGNAME': 'cltbld', 16:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:45 INFO - 'MOZ_NO_REMOTE': '1', 16:53:45 INFO - 'NO_EM_RESTART': '1', 16:53:45 INFO - 'PAGER': '/bin/cat', 16:53:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:45 INFO - 'PWD': '/builds/slave/test', 16:53:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:45 INFO - 'SHELL': '/bin/bash', 16:53:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IyBriXwBpB/Listeners', 16:53:45 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 16:53:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:45 INFO - 'USER': 'cltbld', 16:53:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:45 INFO - 'XPC_FLAGS': '0x0', 16:53:45 INFO - 'XPC_SERVICE_NAME': '0', 16:53:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:45 INFO - Downloading/unpacking psutil>=0.7.1 16:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:53:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:48 INFO - Installing collected packages: psutil 16:53:48 INFO - Running setup.py install for psutil 16:53:48 INFO - building 'psutil._psutil_osx' extension 16:53:48 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 16:53:48 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 16:53:48 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 16:53:49 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 16:53:49 INFO - building 'psutil._psutil_posix' extension 16:53:49 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 16:53:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:53:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:53:49 INFO - ^ 16:53:49 INFO - 1 warning generated. 16:53:49 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 16:53:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:49 INFO - Successfully installed psutil 16:53:49 INFO - Cleaning up... 16:53:49 INFO - Return code: 0 16:53:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103577a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103587420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc688d891b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103416e00>, '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 0x10327fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103411b20>, '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.mC139zXAHg/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.IyBriXwBpB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 16:53:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:53:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC139zXAHg/Render', 16:53:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:49 INFO - 'HOME': '/Users/cltbld', 16:53:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:49 INFO - 'LOGNAME': 'cltbld', 16:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:49 INFO - 'MOZ_NO_REMOTE': '1', 16:53:49 INFO - 'NO_EM_RESTART': '1', 16:53:49 INFO - 'PAGER': '/bin/cat', 16:53:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:49 INFO - 'PWD': '/builds/slave/test', 16:53:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:49 INFO - 'SHELL': '/bin/bash', 16:53:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IyBriXwBpB/Listeners', 16:53:49 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 16:53:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:49 INFO - 'USER': 'cltbld', 16:53:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:49 INFO - 'XPC_FLAGS': '0x0', 16:53:49 INFO - 'XPC_SERVICE_NAME': '0', 16:53:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:53:52 INFO - Installing collected packages: mozsystemmonitor 16:53:52 INFO - Running setup.py install for mozsystemmonitor 16:53:52 INFO - Successfully installed mozsystemmonitor 16:53:52 INFO - Cleaning up... 16:53:52 INFO - Return code: 0 16:53:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103577a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103587420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc688d891b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103416e00>, '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 0x10327fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103411b20>, '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.mC139zXAHg/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.IyBriXwBpB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 16:53:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:53:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC139zXAHg/Render', 16:53:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:52 INFO - 'HOME': '/Users/cltbld', 16:53:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:52 INFO - 'LOGNAME': 'cltbld', 16:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:52 INFO - 'MOZ_NO_REMOTE': '1', 16:53:52 INFO - 'NO_EM_RESTART': '1', 16:53:52 INFO - 'PAGER': '/bin/cat', 16:53:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:52 INFO - 'PWD': '/builds/slave/test', 16:53:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:52 INFO - 'SHELL': '/bin/bash', 16:53:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IyBriXwBpB/Listeners', 16:53:52 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 16:53:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:52 INFO - 'USER': 'cltbld', 16:53:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:52 INFO - 'XPC_FLAGS': '0x0', 16:53:52 INFO - 'XPC_SERVICE_NAME': '0', 16:53:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:52 INFO - Downloading/unpacking blobuploader==1.2.4 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:54 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:53:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:56 INFO - Downloading docopt-0.6.1.tar.gz 16:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:56 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:56 INFO - Running setup.py install for blobuploader 16:53:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:53:56 INFO - Running setup.py install for requests 16:53:56 INFO - Running setup.py install for docopt 16:53:57 INFO - Successfully installed blobuploader requests docopt 16:53:57 INFO - Cleaning up... 16:53:57 INFO - Return code: 0 16:53:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:57 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 0x103577a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103587420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc688d891b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103416e00>, '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 0x10327fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103411b20>, '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.mC139zXAHg/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.IyBriXwBpB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 16:53:57 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 16:53:57 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 16:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC139zXAHg/Render', 16:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:57 INFO - 'HOME': '/Users/cltbld', 16:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:57 INFO - 'LOGNAME': 'cltbld', 16:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:57 INFO - 'MOZ_NO_REMOTE': '1', 16:53:57 INFO - 'NO_EM_RESTART': '1', 16:53:57 INFO - 'PAGER': '/bin/cat', 16:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:57 INFO - 'PWD': '/builds/slave/test', 16:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:57 INFO - 'SHELL': '/bin/bash', 16:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IyBriXwBpB/Listeners', 16:53:57 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 16:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:57 INFO - 'USER': 'cltbld', 16:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:57 INFO - 'XPC_FLAGS': '0x0', 16:53:57 INFO - 'XPC_SERVICE_NAME': '0', 16:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:57 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-lt44d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:57 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-6JcJ8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:57 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-va4IaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:57 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-3lMsNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:57 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-85PkUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:57 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-JWDDQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:57 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-841kCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:58 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-UCPKhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:58 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-SnPV28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:58 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-x4Dw_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:58 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-XAnelh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:58 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-lyK7ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:58 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-KOwLtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:58 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-MYh3wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:58 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-UJ9HsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:58 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-AL1iLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:59 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Tsky3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:59 INFO - Running setup.py install for manifestparser 16:53:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:53:59 INFO - Running setup.py install for mozcrash 16:53:59 INFO - Running setup.py install for mozdebug 16:53:59 INFO - Running setup.py install for mozdevice 16:53:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:53:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:53:59 INFO - Running setup.py install for mozfile 16:53:59 INFO - Running setup.py install for mozhttpd 16:53:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:54:00 INFO - Running setup.py install for mozinfo 16:54:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:54:00 INFO - Running setup.py install for mozInstall 16:54:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:54:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:54:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:54:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:54:00 INFO - Running setup.py install for mozleak 16:54:00 INFO - Running setup.py install for mozlog 16:54:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:54:00 INFO - Running setup.py install for moznetwork 16:54:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:54:00 INFO - Running setup.py install for mozprocess 16:54:00 INFO - Running setup.py install for mozprofile 16:54:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:54:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:54:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:54:01 INFO - Running setup.py install for mozrunner 16:54:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:54:01 INFO - Running setup.py install for mozscreenshot 16:54:01 INFO - Running setup.py install for moztest 16:54:01 INFO - Running setup.py install for mozversion 16:54:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:54:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:54:01 INFO - Cleaning up... 16:54:01 INFO - Return code: 0 16:54:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:01 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 0x103577a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103587420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc688d891b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103416e00>, '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 0x10327fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103411b20>, '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.mC139zXAHg/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.IyBriXwBpB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 16:54:01 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 16:54:01 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 16:54:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC139zXAHg/Render', 16:54:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:01 INFO - 'HOME': '/Users/cltbld', 16:54:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:01 INFO - 'LOGNAME': 'cltbld', 16:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:01 INFO - 'MOZ_NO_REMOTE': '1', 16:54:01 INFO - 'NO_EM_RESTART': '1', 16:54:01 INFO - 'PAGER': '/bin/cat', 16:54:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:01 INFO - 'PWD': '/builds/slave/test', 16:54:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:01 INFO - 'SHELL': '/bin/bash', 16:54:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IyBriXwBpB/Listeners', 16:54:01 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 16:54:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:01 INFO - 'USER': 'cltbld', 16:54:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:01 INFO - 'XPC_FLAGS': '0x0', 16:54:01 INFO - 'XPC_SERVICE_NAME': '0', 16:54:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:01 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-v47Prm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:02 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)) 16:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:02 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-B34baD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 16:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:02 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Xcxc50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:02 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)) 16:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:02 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Cndubh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:02 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)) 16:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:02 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-RNmFlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:02 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)) 16:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:02 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-mQ_5W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:02 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)) 16:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:02 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-qo__rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:02 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)) 16:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:02 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Xfq1wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:02 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)) 16:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:02 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-PCSdta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:02 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)) 16:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:02 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-jnwmLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:03 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)) 16:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:03 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-snKyr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:03 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)) 16:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:03 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-4fBoCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:03 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)) 16:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:03 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-8YSeZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:03 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)) 16:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:03 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-ZyBMM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:03 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)) 16:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:03 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-yKlEX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:03 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)) 16:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:03 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-93P6z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:03 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)) 16:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:03 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-g3QweT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:03 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)) 16:54:03 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:54:03 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:54:03 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)) 16:54:03 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)) 16:54:03 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)) 16:54:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:06 INFO - Downloading blessings-1.6.tar.gz 16:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:54:06 INFO - Installing collected packages: blessings 16:54:06 INFO - Running setup.py install for blessings 16:54:06 INFO - Successfully installed blessings 16:54:06 INFO - Cleaning up... 16:54:06 INFO - Return code: 0 16:54:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:54:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:06 INFO - Reading from file tmpfile_stdout 16:54:06 INFO - Current package versions: 16:54:06 INFO - blessings == 1.6 16:54:06 INFO - blobuploader == 1.2.4 16:54:06 INFO - docopt == 0.6.1 16:54:06 INFO - manifestparser == 1.1 16:54:06 INFO - mozInstall == 1.12 16:54:06 INFO - mozcrash == 0.17 16:54:06 INFO - mozdebug == 0.1 16:54:06 INFO - mozdevice == 0.48 16:54:06 INFO - mozfile == 1.2 16:54:06 INFO - mozhttpd == 0.7 16:54:06 INFO - mozinfo == 0.9 16:54:06 INFO - mozleak == 0.1 16:54:06 INFO - mozlog == 3.1 16:54:06 INFO - moznetwork == 0.27 16:54:06 INFO - mozprocess == 0.22 16:54:06 INFO - mozprofile == 0.28 16:54:06 INFO - mozrunner == 6.11 16:54:06 INFO - mozscreenshot == 0.1 16:54:06 INFO - mozsystemmonitor == 0.0 16:54:06 INFO - moztest == 0.7 16:54:06 INFO - mozversion == 1.4 16:54:06 INFO - psutil == 3.1.1 16:54:06 INFO - requests == 1.2.3 16:54:06 INFO - wsgiref == 0.1.2 16:54:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:06 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')]} 16:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:06 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')]} 16:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:06 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 0x103577a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103587420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc688d891b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103416e00>, '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 0x10327fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103411b20>, '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.mC139zXAHg/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.IyBriXwBpB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 16:54:06 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 16:54:06 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 16:54:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC139zXAHg/Render', 16:54:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:06 INFO - 'HOME': '/Users/cltbld', 16:54:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:06 INFO - 'LOGNAME': 'cltbld', 16:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:06 INFO - 'MOZ_NO_REMOTE': '1', 16:54:06 INFO - 'NO_EM_RESTART': '1', 16:54:06 INFO - 'PAGER': '/bin/cat', 16:54:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:06 INFO - 'PWD': '/builds/slave/test', 16:54:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:06 INFO - 'SHELL': '/bin/bash', 16:54:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IyBriXwBpB/Listeners', 16:54:06 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 16:54:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:06 INFO - 'USER': 'cltbld', 16:54:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:06 INFO - 'XPC_FLAGS': '0x0', 16:54:06 INFO - 'XPC_SERVICE_NAME': '0', 16:54:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:07 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)) 16:54:07 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)) 16:54:07 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)) 16:54:07 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)) 16:54:07 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)) 16:54:07 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)) 16:54:07 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)) 16:54:07 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)) 16:54:07 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)) 16:54:07 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)) 16:54:07 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)) 16:54:07 INFO - Cleaning up... 16:54:07 INFO - Return code: 0 16:54:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103577a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103587420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc688d891b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103416e00>, '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 0x10327fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103411b20>, '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.mC139zXAHg/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.IyBriXwBpB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 16:54: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', 'jsonschema'] in /builds/slave/test/build 16:54: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 jsonschema 16:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC139zXAHg/Render', 16:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:07 INFO - 'HOME': '/Users/cltbld', 16:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:07 INFO - 'LOGNAME': 'cltbld', 16:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:07 INFO - 'MOZ_NO_REMOTE': '1', 16:54:07 INFO - 'NO_EM_RESTART': '1', 16:54:07 INFO - 'PAGER': '/bin/cat', 16:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:07 INFO - 'PWD': '/builds/slave/test', 16:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:07 INFO - 'SHELL': '/bin/bash', 16:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IyBriXwBpB/Listeners', 16:54:07 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 16:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:07 INFO - 'USER': 'cltbld', 16:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:07 INFO - 'XPC_FLAGS': '0x0', 16:54:07 INFO - 'XPC_SERVICE_NAME': '0', 16:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:07 INFO - Downloading/unpacking jsonschema 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:54:09 INFO - Downloading/unpacking functools32 (from jsonschema) 16:54:09 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 16:54:09 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 16:54:09 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 16:54:09 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 16:54:09 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 16:54:09 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 16:54:10 INFO - Downloading functools32-3.2.3-2.tar.gz 16:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:54:10 INFO - warning: no files found matching '*.txt' 16:54:10 INFO - no previously-included directories found matching 'build' 16:54:10 INFO - no previously-included directories found matching 'dist' 16:54:10 INFO - no previously-included directories found matching '.git*' 16:54:10 INFO - Installing collected packages: jsonschema, functools32 16:54:10 INFO - Running setup.py install for functools32 16:54:10 INFO - warning: no files found matching '*.txt' 16:54:10 INFO - no previously-included directories found matching 'build' 16:54:10 INFO - no previously-included directories found matching 'dist' 16:54:10 INFO - no previously-included directories found matching '.git*' 16:54:10 INFO - Successfully installed jsonschema functools32 16:54:10 INFO - Cleaning up... 16:54:10 INFO - Return code: 0 16:54:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:10 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 0x103577a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103587420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc688d891b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103416e00>, '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 0x10327fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103411b20>, '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.mC139zXAHg/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.IyBriXwBpB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 16:54:10 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 16:54:10 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 16:54:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC139zXAHg/Render', 16:54:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:10 INFO - 'HOME': '/Users/cltbld', 16:54:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:10 INFO - 'LOGNAME': 'cltbld', 16:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:10 INFO - 'MOZ_NO_REMOTE': '1', 16:54:10 INFO - 'NO_EM_RESTART': '1', 16:54:10 INFO - 'PAGER': '/bin/cat', 16:54:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:10 INFO - 'PWD': '/builds/slave/test', 16:54:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:10 INFO - 'SHELL': '/bin/bash', 16:54:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IyBriXwBpB/Listeners', 16:54:10 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 16:54:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:10 INFO - 'USER': 'cltbld', 16:54:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:10 INFO - 'XPC_FLAGS': '0x0', 16:54:10 INFO - 'XPC_SERVICE_NAME': '0', 16:54:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:10 INFO - Downloading/unpacking flake8 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:54:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:54:13 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 16:54:13 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 16:54:13 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 16:54:13 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 16:54:13 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 16:54:13 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 16:54:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:54:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:54:13 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 16:54:13 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 16:54:13 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 16:54:13 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 16:54:13 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 16:54:13 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 16:54:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:54:13 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 16:54:13 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 16:54:13 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 16:54:13 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 16:54:13 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 16:54:13 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 16:54:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:54:14 INFO - no previously-included directories found matching 'docs/_build' 16:54:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:54:14 INFO - Running setup.py install for pep8 16:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:54:14 INFO - no previously-included directories found matching 'docs/_build' 16:54:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:54:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:54:14 INFO - Cleaning up... 16:54:14 INFO - Return code: 0 16:54:14 INFO - Running post-action listener: _resource_record_post_action 16:54:14 INFO - Running post-action listener: _start_resource_monitoring 16:54:14 INFO - Starting resource monitoring. 16:54:14 INFO - ##### 16:54:14 INFO - ##### Running install step. 16:54:14 INFO - ##### 16:54:14 INFO - Running pre-action listener: _resource_record_pre_action 16:54:14 INFO - Running main action method: install 16:54:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:15 INFO - Reading from file tmpfile_stdout 16:54:15 INFO - Detecting whether we're running mozinstall >=1.0... 16:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:54:15 INFO - Reading from file tmpfile_stdout 16:54:15 INFO - Output received: 16:54:15 INFO - Usage: mozinstall [options] installer 16:54:15 INFO - Options: 16:54:15 INFO - -h, --help show this help message and exit 16:54:15 INFO - -d DEST, --destination=DEST 16:54:15 INFO - Directory to install application into. [default: 16:54:15 INFO - "/builds/slave/test"] 16:54:15 INFO - --app=APP Application being installed. [default: firefox] 16:54:15 INFO - mkdir: /builds/slave/test/build/application 16:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:54:49 INFO - Reading from file tmpfile_stdout 16:54:49 INFO - Output received: 16:54:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:54:49 INFO - Running post-action listener: _resource_record_post_action 16:54:49 INFO - ##### 16:54:49 INFO - ##### Running run-tests step. 16:54:49 INFO - ##### 16:54:49 INFO - Running pre-action listener: _resource_record_pre_action 16:54:49 INFO - Running main action method: run_tests 16:54:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:54:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:54:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:54:49 INFO - 2016-03-22 16:54:49.120 screenresolution[1651:8044] starting screenresolution argv=screenresolution get 16:54:49 INFO - 2016-03-22 16:54:49.123 screenresolution[1651:8044] Display 0: 1600x1200x32@60 16:54:49 INFO - 2016-03-22 16:54:49.128 screenresolution[1652:8046] starting screenresolution argv=screenresolution list 16:54:49 INFO - Available Modes on Display 0 16:54:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:54:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:54:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:54:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:54:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:54:49 INFO - Intel Iris: 16:54:49 INFO - Chipset Model: Intel Iris 16:54:49 INFO - Type: GPU 16:54:49 INFO - Bus: Built-In 16:54:49 INFO - VRAM (Dynamic, Max): 1536 MB 16:54:49 INFO - Vendor: Intel (0x8086) 16:54:49 INFO - Device ID: 0x0a2e 16:54:49 INFO - Revision ID: 0x0009 16:54:49 INFO - Displays: 16:54:49 INFO - Display: 16:54:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:54:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:54:49 INFO - Display Serial Number: 1600x1200 60 16:54:49 INFO - Main Display: Yes 16:54:49 INFO - Mirror: Off 16:54:49 INFO - Online: Yes 16:54:49 INFO - Rotation: Supported 16:54:49 INFO - Return code: 0 16:54:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:54:49 INFO - Python 2.7.3 16:54:49 INFO - Return code: 0 16:54:49 INFO - grabbing minidump binary from tooltool 16:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:49 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 0x103416e00>, '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 0x10327fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103411b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:54:49 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 16:54:49 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 16:54:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:54:49 INFO - Return code: 0 16:54:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:54:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:54:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:54:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:54:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:54:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:54:50 INFO - Return code: 0 16:54:50 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/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--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 16:54:50 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/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0120 --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 16:54:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC139zXAHg/Render', 16:54:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:50 INFO - 'HOME': '/Users/cltbld', 16:54:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:50 INFO - 'LOGNAME': 'cltbld', 16:54:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:54:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:50 INFO - 'MOZ_NO_REMOTE': '1', 16:54:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:54:50 INFO - 'NO_EM_RESTART': '1', 16:54:50 INFO - 'PAGER': '/bin/cat', 16:54:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:50 INFO - 'PWD': '/builds/slave/test', 16:54:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:54:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:50 INFO - 'SHELL': '/bin/bash', 16:54:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IyBriXwBpB/Listeners', 16:54:50 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 16:54:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:50 INFO - 'USER': 'cltbld', 16:54:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:50 INFO - 'XPC_FLAGS': '0x0', 16:54:50 INFO - 'XPC_SERVICE_NAME': '0', 16:54:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:50 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/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--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 16:54:50 INFO - mozversion application_buildid: 20160322142325 16:54:50 INFO - mozversion application_changeset: abfac0d05b79b49597d5fa8d4ce87caf4caaff8e 16:54:50 INFO - mozversion application_display_name: Nightly 16:54:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:54:50 INFO - mozversion application_name: Firefox 16:54:50 INFO - mozversion application_remotingname: firefox 16:54:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:54:50 INFO - mozversion application_vendor: Mozilla 16:54:50 INFO - mozversion application_version: 48.0a1 16:54:50 INFO - mozversion platform_buildid: 20160322142325 16:54:50 INFO - mozversion platform_changeset: abfac0d05b79b49597d5fa8d4ce87caf4caaff8e 16:54:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:54:50 INFO - mozversion platform_version: 48.0a1 16:54:50 INFO - using testdate: 1458690890 16:54:50 INFO - actual date: 1458690890 16:54:50 INFO - starting webserver on 'localhost:49270' 16:54:50 INFO - SUITE-START | Running 2 tests 16:54:50 INFO - TEST-START | dromaeo_css 16:54:50 INFO - operating with platform_type : mac_ 16:54:50 INFO - Initialising browser for dromaeo_css test... 16:54:50 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmp9KIePM/profile http://localhost:49270/getInfo.html) 16:54:53 INFO - PROCESS | 1670 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 16:54:53 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 16:54:53 INFO - PROCESS | 1670 | colorDepth:24 16:54:53 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 16:54:53 INFO - PROCESS | 1670 | __metrics 16:54:53 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 16:54:54 INFO - TEST-INFO | 1670: exit 0 16:54:54 INFO - Browser initialized. 16:54:54 INFO - Running cycle 1/1 for dromaeo_css test... 16:54:54 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmp9KIePM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:06 INFO - PROCESS | 1675 | RSS: Main: 257925120 16:55:06 INFO - PROCESS | 1675 | 16:55:56 INFO - PROCESS | 1675 | 1458690956358 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] 16:58:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 16:58:09 INFO - PROCESS | 1675 | RSS: Main: 268812288 16:58:09 INFO - PROCESS | 1675 | 17:01:11 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 17:01:11 INFO - PROCESS | 1675 | RSS: Main: 280702976 17:01:11 INFO - PROCESS | 1675 | 17:04:13 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 17:04:14 INFO - PROCESS | 1675 | RSS: Main: 284569600 17:04:14 INFO - PROCESS | 1675 | 17:07:16 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 17:07:16 INFO - PROCESS | 1675 | RSS: Main: 284348416 17:07:16 INFO - PROCESS | 1675 | 17:10:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 17:10:19 INFO - PROCESS | 1675 | RSS: Main: 287711232 17:10:19 INFO - PROCESS | 1675 | 17:13:22 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 17:13:22 INFO - PROCESS | 1675 | RSS: Main: 289353728 17:13:22 INFO - PROCESS | 1675 | 17:13:22 INFO - PROCESS | 1675 | __start_tp_report 17:13:22 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 17:13:22 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 17:13:22 INFO - PROCESS | 1675 | |i|pagename|runs| 17:13:22 INFO - PROCESS | 1675 | |0;dojo.html;3335.9666403335964;3460.3079384123166;3480.965190348096;3512.490688850118;3539.309834582254;5611.102223644223;5749.913751293729;5782.595218334718;5804.82585522435;5825.883482330356;5558.221848941142;5616.269884914956;5682.460166284207;5706.65760054397;5846.181534585162;5144.485551444854;5192.247124167013;5195.896082078356;5225.163973764198;5305.761240744157;5233.031889100528;5243.764030618612;5258.842234732964;5271.341082364705;5301.310829592167;4672.813087476497;5076.771545280471;5209.60927930403;5231.110711179071;5285.814996475144;5134.460881607415;5161.509656582619;5171;5171.948280517222;5179.300794392784;5027;5097.49025097491;5110.66780659256;5148.9702059588235;5209.088409528317;5504.926539324833;5626.7186640668215;5660.179274005246;5672.205891175238;5676.205331253628;6182.876342473125;6217.098520714516;6280.811575652692;6298.496120310364;6298.716557754912;6143.293521245069;6157.538184636125;6179.0422484514975;6205.627662340274;6235.688215589203;5804.361520232771;5809.796657116981;5813.924423981534;5815.709214539298;5846.064629659234;6249.343818899041;6267.2165979252595;6275.278342990615;6277.937220627827;6302;5947.732352044169;6097.222222222223;6129.969350153221;6185.969070154621;6215.160953271341;6100.664463454464;6139.216166136444;6224.533160013018;6254.186955695822;6281.497480201573;6208.50331973441;6218.253809542884;6289.245290565162;6295.496360291166;6302.779402720975;6100.786472473442;6149.477294430024;6172.351903050205;6201.96899015502;6273.498120150377;4881.148599003121;4894.486078961658;4900.681455705368;4916.483769204254;4918.262260660858;4182.686298527623;4419.138268037702;4419.558044195554;4422.380866678667;4432.977835110803;5537.058700021006;5562.332520097614;5645.98372292983;5705.828825135252;5742.310922689304;6247.687615619201;6250.15622890913;6253.499720022387;6264.404881536247;6267.623942563369;5590.468905453975;5761.53907687384;5789.739461724233;5805.042168042226;5821.854453638608;5306.575473962151;5371.650842695212;5377.784888604412;5381.0852155133725;5449.863753406117;6330.525210609223;6350.618962862243;6365.872682546323;6374.426301632875;6377.4579160771855;5348.652337598043;5505.394406615349;6147.72335244924;6281.905771413341;6302.810915672537;5165.483451654804;6322.3045464997895;6328.46208072319;6330.968345158245;6334;6115;6118.969405152946;6178.41305076017;6180;6189.752409903554;4947.911459478909;6058.4244496772735;6064.514838812973;6154.876902461836;6185.288691800501;5994.970025149846;6035.336113027475;6094.457644858721;6109.254396435016;6115.240341084353;6127.754889804358;6133.877322453615;6196.411340922786;6212.627242365473;6229.56393052482;5818.6217895836635;5832.358440571449;6066.1204125402455;6097.817065488042;6133.815985520441;5384.246205531151;5555.055640541199;6102.14613164857;6157.076438534255;6179.3820617937845;6032.668203248688;6034.517238620988;6041.9395806041375;6046.274447066205;6055.455009049207 17:13:22 INFO - PROCESS | 1675 | |1;ext.html;482.9903401931961;541.2936118365533;558.4917724870369;573.6099452372385;596.8478038100284;30012.849935750317;38401.61598384015;38805.417918731204;38835;38876.22247555051;40318.798406008005;40365.789026329185;40973.565925192626;41084;41094.383584246185;9394.953025234881;9495.620175193018;9554.283428742838;9625.374350667184;9662.71011869645;9342.532873356338;9558.761030974212;9560.665376711817;9583.904160958406;9608.375455595398;9489.240860731159;9548.331616786827;9608.663696770614;9609.375390599624;9623.989481104489;9457.763555911088;9507.477088760115;9542.856857147113;9604.519774011307;9607.855882161773;9505.904940950571;9624.47065411402;9646.517674116267;9654.22766178704;9680.177184939288;29519.262018449495;32998.34003319944;38453.61546384556;39634.40548391776;39680.20639587192;3206.2625596112794;3217.067050555336;3220.066180807563;3264.508928571439;3484.285721427101;24150.637740433907;26197;28445.431091378057;29092.41815163706;29197;2110.6095372356162;2671.6526851509375;2750.8624568771484;2810.367667274847;2818.5067613167816;475530;537357;537387.999999996;545484.5451545473;545623;67237;67555.64888702199;68006.29984250433;68228.6588567054;68402;71953.56092878217;73540.63229683817;73950;74421.25578744251;74748;17051.829481705023;17193.7420938686;17326.65346693059;17334.47996560105;17449.651006980042;12599.118061735591;12916.22502649844;12918.41867115982;13023.413946372437;13035.674108147372;22201.555968880533;22290.777092229193;22370.217042403765;22418;22549.66175507369;9469.857952130724;9475.00512446197;9582.233421326277;9585;9611.038896110473;992.2657233647193;1026.8665073540542;1060.3054998975683;1126.3917484558247;1155.3356819828464;29632.962846300277;29636.851815741215;29971.95098171597;30000.69999299979;30145.69854301429;961.2166084640995;966.5843687214425;986.8174387738292;1054.262016588376;1147.8450409194652;13000.674983125498;14226.928865355814;14561.635959101108;14563;14781.704365912621;479725;485977;490008;490713;491463;58880;58935.70532147398;59930.700346497986;60457.093143602884;60662.69668651628;1443.5741456270425;1467.948621798232;1473.963150921214;1486.9628259293604;1491.1798510819006;28264;28359.85820070969;28499.43001139924;28512.85743571269;28841.567376489787;48680;49835;50098.49901501084;50319;50462.49537504578;427620;436341;437873.970082399;438846;439935;34191.65808341885;44390.556094438645;45136.32295515504;45267.86830329136;46068.769656151504;44391.33412998743;44407.555924441636;44430;44468.924451060666;44876;36301.91094267176;36662.8166859164;36767;37094.25811483809;37149.69976050825;37780.62219377881;37889;37978.24043519169;38606;38697.61302387053;32804;37242;38216.66241681528;38484.42273365846;38853.41719874261;27892.58161127544;32704.34591308208;32969;33400.66599334073;34249.97250082502;24913;25233.49533009366;25313.240602781945;25354.746452535237;25470.108546200794 17:13:22 INFO - PROCESS | 1675 | |2;jquery.html;351.3482489981085;356.37812018028546;362.2627952117441;373.3764613096129;380.4407520944211;16113.67772644548;19676.70484942727;21004.159833606656;21124.943752812374;21149.471263218427;17445.651086978254;20243.59512809743;20872.89563552184;21040.158393664275;21499.355019349405;4840.6369522285795;5617.606767526265;5833.562482813784;5860.355360910296;5862.765489380419;4183.497980242375;5686.573506986972;6178.258608966908;6440.4847612190915;6465.3534646535445;6373.394527519901;6382.170317858695;6391.265004524493;6397.456216221627;6411.422971932525;7060.3292687194635;7341.1557670868;7345.55926644403;7433.665485053131;7479.7382091626805;6997.335253150943;7035.5075144739885;7068.328508791708;7116.074910261685;7163.534370265968;27480.58779118315;28187.617485901617;28502;28730;29240.268993275127;2314.664373665809;2357.6934998450265;2359.3629719975684;2726.2502811726936;2815.0428854189468;14912.925435372754;15703.214839257991;15881.126538040404;16165.595860103474;16269.023858568524;1865.486991077451;1895.6966885298286;1941.7864034956144;1984.335247692025;2194.1004188282727;106370.46814765877;112067.43966280116;113315;113463;113685;20078;20218;20476.283330083377;20611.896940515202;20648.58702825935;28764.85617571899;28779.712202878123;28997.56503652447;29555.408891822044;29613.703862961527;9551.42691438516;10587.84118238227;10616.097631701237;11042.227044106836;11116.220944763809;9297.302702297355;9310.348275620641;9340.57967391469;9387.57755900986;9445.433274003582;9047.366684332164;9138.725838224864;9184.49485278316;9215.216706579882;9216.216621587106;1882.7081802320663;1925.6822624266838;1966.606678664273;2015.6069566434405;3769.3991146109097;906.2387594420718;918.2103391083663;955.47926380123;1007.2445665750687;1072.367303291062;17527.29890804379;17848.75058745875;17861;19253.22987080501;20824.687629685566;822.2722890242179;981.5926390547985;981.6024510073431;996.2378780233128;1043.5564884923876;9382;11043.889561104446;11077.279976801483;11118.666440006813;11167.218294719454;549749.2512537412;586554.1344586585;600554;601125;624874;107059.46470267599;108176.91823081826;110749.78500430107;113529;118932.40533797276;1027.7071034755209;1031.6492392586406;1041.1930753665818;1071.6195750508614;1080.3355936099242;12919.289439080942;14763.966522343762;16355.754663679816;16590.336386544404;17711.937283763014;42733.57266427296;45273;47307;52198.73900630473;52305.73847130892;70494;72373;72778.27221727715;73745.6312718433;74507;7571.129320128035;7585.772426827204;7692.461527693232;7733.651985660546;7856.410769192447;10589.682309530726;12016.63950081499;12251.08116891219;12398.5660501882;12406.193597416139;10119.494025298558;10379.325343852626;10429.9478502607;10612.0449159576;10658.200634952254;9196;9669.597908303398;10033.046860548237;10291.35291601598;10352.430616316175;10034.849477257701;10281.897181028095;10319;10502.317349372266;11092.889071109186;6531.934680653323;7312.866505691626;7670.923290767244;7684.923150768421;7817.061952565501;9409.905900941178;10699.090577301016;10708;10793.67618971432;10953.890461095287 17:13:22 INFO - PROCESS | 1675 | |3;mootools.html;1597.3291217688572;1605.325763179464;1920.1071501751683;2005.8696184747998;2006.1774672384315;7981.321587665056;8368.414211005233;8888.422252553588;9084.772880677987;9119.270458363331;8665.176808203227;8690.956545217281;8780.385373023892;8814.86777698335;8899.555022248878;2422.2127808462233;2442.084218418098;2461.8153638477097;2467.3214865911928;2475.6905386826647;2413.703607578513;2447.730749617541;2457.9631305530434;2466.469709012562;2468.5309791139716;2344.3787396339985;2426.954172513502;2448.5959816630325;2470.6170543565777;2478.62820576914;2444.6577479152934;2450.7181674107437;2471.456279618481;2486.5151295497385;2487.1170734389393;2296.0700916128994;2352.1532248390567;2358.6462030695534;2359.7522260162777;2424.9272521824373;8809.64761409543;8962.507062111581;9013.954930225373;9042.638294468214;9043.231325337354;5464;5474.315710536183;5486.31421072366;5494.5054945054735;5538.0585300499015;3034.833084180369;3579.588347340063;3658.762180458262;3670.871519496805;3684.3552378333684;960.846264597661;1008.6822650864954;1016.2327442780727;1041.9583216671324;1043.12377602814;8786.956065219696;10506.52720627566;11695.1228657851;11975.281483111128;12049.518019279218;4903.87740306488;4932.161532539477;5028.120078986236;5038.773255203525;5048.747562621854;10042.548085336177;10129.290949633601;10154.984501549934;10179.98200179976;10266.794664106676;5474.835754927359;5506.807261745819;5570.164475328733;5620.775168993277;5642.802501912413;4489.326601009875;4968.30443737877;4985.252212168131;5048.747562621854;5104.03023425548;3972.3644216925154;4023.1350259694304;4025.7383270087353;4029.073313137995;4104.692148088905;1335.6794369351285;1347.036868638928;1352.4454973460834;1352.9594112176453;1361.9319034048258;1082.1721383141903;1088.4068182840372;1147.6786499780076;1208.1180738061264;1383.4535358533324;8140.75577732669;8145.877811832709;8194.713185038496;8217.260446559838;8245.876311855327;518.271828081546;525.5086494128003;531.2191079113696;531.5773959702046;533.0059439146042;6063.120847477091;6113.510919126459;6156.445919867144;6162.322144564095;6187.071939209065;10492.4229167395;10831.241813073168;11040.723981900517;11087.944560277147;11104.944475277573;10272.024157705006;10451.738706532245;10526.368417894952;10563.154947604173;11017.83473247902;8341.16588341161;8484.236418722345;8507.27688146502;8561;8574.271186949054;7537.397008239437;7945.046594408708;7965.203479651988;7984.481008734414;8032.558209298545;9369.484678342484;9649.228061755182;9728.9027109728;9731.12419882214;9843.261755368232;7936.2857342839425;9566.282528810229;9952.402855828674;9968.850467242852;10022.24833137503;6827.52207345481;6899.17209934811;7116.857662846611;7348.375388092072;7585.886211706939;8329.083800782031;8362.121977192308;8407;8424.368172386972;8426.452280601741;6726.6636668167375;7229.566226026455;7426.331630153312;7482.476226664081;7583.165851756192;7316.926830731624;7346.501559656121;7440.921066445443;7444.404447644067;7547.471676982558;6636.800895973129;7392.334689877936;7667.731629392944;7680.155182929761;7757.806054848674;6622.238442579165;6628.635425051669;6704.932950670431;6784.457243420416;6936.0636314098965;7051.259617740268;7173.1392232932385;7228.819279518054;7238.782836514913;7268.127824661075 17:13:22 INFO - PROCESS | 1675 | |4;prototype.html;306.50805457241125;329.17213208779924;332.6025399647422;338.2170275811497;339.5382280099065;6843.076184715062;6868.381845633892;6885;6898.310168983099;6912.758053468124;6010.489108425778;6224.23021755319;6789.966050169743;6800.8979865301935;6813.284605116466;4646.581807637312;4827.734474603895;4976.726280054613;4994.97502512487;5051.939092790519;4586.312053192015;4703.905921881577;4964.280179374006;4981.0037992401485;5046.21783623539;4864.416270047582;4987.800487980477;5006.949930500685;5013.799448022075;5036.9926014797;5014.5737612303;5016.724080175589;5021.27191557224;5033.496650334974;5054.570361519293;4288.0351920817875;4297.484301883763;4311.892202694927;4326.939899724556;4328.480582330109;6203.131561581382;6462.709178086998;6510.5117116216;6551.606903585753;6573.276939536647;5790.913136302959;5832.387599302097;5845.09401042839;5853.88292234153;5854.151148083547;7129.429645628389;7259.346658800733;7286.307800758919;7288.489805713602;7322.707091716325;3797.3544497435228;4064.4309796628495;4601.964557974463;4637.698549594265;4652.464966528859;7560.3573696236435;7588.875114967818;7691.153973062958;7695.730649427299;7705.345045671124;4462.464504259509;4682.4381074271305;4699;4712.104700107037;4718.150732868048;4750.976245118753;4784.928226076611;4788.904221915612;4791.688540244873;4797.424309082932;5758.280214973129;5768.134779782982;5772.6536407815665;5785.363610002896;5787.074068149076;7224.711011559584;7240.52936559122;7269.890951635624;7271.490995630361;7298.781036568911;1652.339064374236;1676.3629820668068;1679.0681171949684;1682.512071499276;1685.4690772406652;1020.9132223760915;1060.316096118015;1068.3750006246432;1073.7476692977143;1081.324172392255;6691.498137639696;6709.899351509731;6723.697433615499;6736.955771855272;6750.291219421988;6082.543809214327;7206.963965180141;7537.397008239437;7584;7588.089429268523;4845.75771211438;6554.606723596599;6655.96832490955;6750.831229219309;6799.762008329783;3536.681698647134;3644.653757892996;3755.530558680165;3942.56631770505;4033.69747268956;7944.483608565425;7960.243776841191;7989.201079892081;7991.320737737357;8000;7520.6239688015385;7894.328982036476;7894.960525197337;7905.367570594339;7907.169747176464;6398.936010639834;6741.426978706865;7759.844803104019;7915.643796029078;7985.08171560278;7612.1246056704185;7615.200403957505;7624.504407213513;7626.8093297668;7633.465657403928;7436.996005539183;7441.255874412515;7466.477346585904;7470.738524151629;7483.438742094474;7612.505187162817;7912.525248485109;7973;7974.322182614543;8042.477238979448;4704.364910737144;4731.976340118277;4733.763311834464;4735.810567577396;4750.311204875343;7555.168931417649;7584.734534291273;7602.277783610548;7611.238876112345;7613.619319033915;7195.532290401107;7226.74706385274;7248.456365772483;7266.091738532684;7292.270772922665;5955.106733989936;6573.502069213669;6923.723051077901;7301.853962920818;7370.705171793283;7119.181294151239;7124.715011399486;7185.317394847481;7185.748498802517;7196.4962452627815;7288.489805713549;7317.560946343024;7317.5609463432365;7350.816229594303;7377.852442951218;7125;7141.250168732416;7154.642267886689;7176.7488137914925;7181.497295189495 17:13:22 INFO - PROCESS | 1675 | |5;yui.html;614.198470995351;715.4062128433401;745.7203548669249;755.9092908850937;762.5119923249118;14897.627559311022;14958.252087395615;15198.696026079486;15415.3833846646;15535.912486125962;14123.717525649481;14289.142651440894;14321.92839035806;14331.64170895728;14336.139831610084;743.5204293230863;908.7864351877304;924.935254532183;926.3515539122608;933.5705575435273;902.3187493442442;903.0743487924897;904.5025236120141;939.492673956063;945.0879900895634;979.8971108033661;993.6919554937992;998.8152191844496;1006.4565134827185;1007.4861820471575;977.9070988256104;996.8853581838109;997.3766396002499;999.3654029691126;1000.3347773730496;722.989155162673;728.2135293882594;733.5048842031607;742.1576510660385;742.446877076576;14844.554663360008;14849.92575037118;14876.256187190596;14883.627909302246;15135.848641513665;12965.416556254897;12980.396059309365;12992.870071299261;13101.672458188526;13147.408366623526;9945.15466185375;10111.949440252825;10204.897951020468;10240.590376384936;10537.473126343652;3479.3041391721504;3504.404251277289;3513.49054387115;3557.1818481749083;3619.9276014479565;60149;60546.69726651339;63449.048264276076;64124.03813942748;84068;9467.621295148117;9550;9590.520473976274;9603.807923841485;9826.75433114178;17875.553111172063;22192.88903555472;22557.210497632503;22665.20671776513;22668.093276269094;7564.945757941657;7675.424343174284;7706.998090248232;7783.260590243918;7849.215078492105;3437.8281085945605;4126.71343874503;4144.626983571493;4161.583841615875;4169.207850508394;3018.83396413195;3734.925301493955;3747.1756213632957;3774.7923864187183;3777.773333599993;547.8411260734422;639.3702203329809;659.7756762700704;665.2416245480157;694.2259380790483;531.9679821146963;572.6792995922214;598.4255115089476;609.7774312375951;614.8134101184756;6437.806865794034;8140.470869393471;8390.119037500974;8417.621207045575;8438.789030274293;575.5711994563993;592.4431034827248;592.5259792166249;595.842101843012;628.4626644219218;3737.4206997915367;3801.5248093988253;3885.289548481194;3905.511811023622;3963.2271707016853;89521.55239223762;90119;91009;91450;91549.54225228964;70657.64671176714;73258.2674173262;73629.6318518404;76403;77346;66432.00351994723;67848;69076.96384554236;69749;71190.64404677943;7729.613519324123;7737.845243095219;7811;7943.4439589230515;7962.363010959225;47873.76063119801;49854.75072624614;50224;51289.743551282;51459.228111577606;66672.9999050005;69991.95012074924;70061.64969175121;70652;71224.64387678029;8904.510251936206;10141.239407044353;10256.461183246794;10366.429846358222;10413;10606.454450931875;10849.837252441062;11010;11135.3875536843;11435.542578296774;10312.742181445525;10430.165586753194;10443.94778026105;10702.625408110678;10725.981031801966;10468.162546996375;10680.786384272116;10774.24580279373;11003.669889903316;11300.819460703467;9863.654772082942;10050.69847904564;10124.493775311352;10126.645567405105;10246.333988290737;8631.26634236097;8681.175288347597;8836.469811811312;9061.77345566366;9126.087391261086;8653.221210091122;8905.33210009239;8947;9078.228350590274;9112 17:13:22 INFO - PROCESS | 1675 | __end_tp_report 17:13:22 INFO - PROCESS | 1675 | __start_cc_report 17:13:22 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,375 17:13:22 INFO - PROCESS | 1675 | __end_cc_report 17:13:22 INFO - PROCESS | 1675 | __startTimestamp1458692002293__endTimestamp 17:13:22 INFO - PROCESS | 1675 | 17:13:22 INFO - PROCESS | 1675 | ------- Summary: start ------- 17:13:22 INFO - PROCESS | 1675 | Number of tests: 6 17:13:22 INFO - PROCESS | 1675 | 17:13:22 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5713.51 Median:5846.18 stddev:639.92 (10.9%) stddev-sans-first:614.10 17:13:22 INFO - PROCESS | 1675 | Values: 3336.0 3460.3 3481.0 3512.5 3539.3 5611.1 5749.9 5782.6 5804.8 5825.9 5558.2 5616.3 5682.5 5706.7 5846.2 5144.5 5192.2 5195.9 5225.2 5305.8 5233.0 5243.8 5258.8 5271.3 5301.3 4672.8 5076.8 5209.6 5231.1 5285.8 5134.5 5161.5 5171.0 5171.9 5179.3 5027.0 5097.5 5110.7 5149.0 5209.1 5504.9 5626.7 5660.2 5672.2 5676.2 6182.9 6217.1 6280.8 6298.5 6298.7 6143.3 6157.5 6179.0 6205.6 6235.7 5804.4 5809.8 5813.9 5815.7 5846.1 6249.3 6267.2 6275.3 6277.9 6302.0 5947.7 6097.2 6130.0 6186.0 6215.2 6100.7 6139.2 6224.5 6254.2 6281.5 6208.5 6218.3 6289.2 6295.5 6302.8 6100.8 6149.5 6172.4 6202.0 6273.5 4881.1 4894.5 4900.7 4916.5 4918.3 4182.7 4419.1 4419.6 4422.4 4433.0 5537.1 5562.3 5646.0 5705.8 5742.3 6247.7 6250.2 6253.5 6264.4 6267.6 5590.5 5761.5 5789.7 5805.0 5821.9 5306.6 5371.7 5377.8 5381.1 5449.9 6330.5 6350.6 6365.9 6374.4 6377.5 5348.7 5505.4 6147.7 6281.9 6302.8 5165.5 6322.3 6328.5 6331.0 6334.0 6115.0 6119.0 6178.4 6180.0 6189.8 4947.9 6058.4 6064.5 6154.9 6185.3 5995.0 6035.3 6094.5 6109.3 6115.2 6127.8 6133.9 6196.4 6212.6 6229.6 5818.6 5832.4 6066.1 6097.8 6133.8 5384.2 5555.1 6102.1 6157.1 6179.4 6032.7 6034.5 6041.9 6046.3 6055.5 17:13:22 INFO - PROCESS | 1675 | 17:13:22 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:63725.74 Median:39657.31 stddev:129022.69 (325.3%) stddev-sans-first:129297.25 17:13:22 INFO - PROCESS | 1675 | Values: 483.0 541.3 558.5 573.6 596.8 30012.8 38401.6 38805.4 38835.0 38876.2 40318.8 40365.8 40973.6 41084.0 41094.4 9395.0 9495.6 9554.3 9625.4 9662.7 9342.5 9558.8 9560.7 9583.9 9608.4 9489.2 9548.3 9608.7 9609.4 9624.0 9457.8 9507.5 9542.9 9604.5 9607.9 9505.9 9624.5 9646.5 9654.2 9680.2 29519.3 32998.3 38453.6 39634.4 39680.2 3206.3 3217.1 3220.1 3264.5 3484.3 24150.6 26197.0 28445.4 29092.4 29197.0 2110.6 2671.7 2750.9 2810.4 2818.5 475530.0 537357.0 537388.0 545484.5 545623.0 67237.0 67555.6 68006.3 68228.7 68402.0 71953.6 73540.6 73950.0 74421.3 74748.0 17051.8 17193.7 17326.7 17334.5 17449.7 12599.1 12916.2 12918.4 13023.4 13035.7 22201.6 22290.8 22370.2 22418.0 22549.7 9469.9 9475.0 9582.2 9585.0 9611.0 992.3 1026.9 1060.3 1126.4 1155.3 29633.0 29636.9 29972.0 30000.7 30145.7 961.2 966.6 986.8 1054.3 1147.8 13000.7 14226.9 14561.6 14563.0 14781.7 479725.0 485977.0 490008.0 490713.0 491463.0 58880.0 58935.7 59930.7 60457.1 60662.7 1443.6 1467.9 1474.0 1487.0 1491.2 28264.0 28359.9 28499.4 28512.9 28841.6 48680.0 49835.0 50098.5 50319.0 50462.5 427620.0 436341.0 437874.0 438846.0 439935.0 34191.7 44390.6 45136.3 45267.9 46068.8 44391.3 44407.6 44430.0 44468.9 44876.0 36301.9 36662.8 36767.0 37094.3 37149.7 37780.6 37889.0 37978.2 38606.0 38697.6 32804.0 37242.0 38216.7 38484.4 38853.4 27892.6 32704.3 32969.0 33400.7 34250.0 24913.0 25233.5 25313.2 25354.7 25470.1 17:13:22 INFO - PROCESS | 1675 | 17:13:22 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:34873.60 Median:15103.42 stddev:98255.86 (650.6%) stddev-sans-first:98497.30 17:13:22 INFO - PROCESS | 1675 | Values: 351.3 356.4 362.3 373.4 380.4 16113.7 19676.7 21004.2 21124.9 21149.5 17445.7 20243.6 20872.9 21040.2 21499.4 4840.6 5617.6 5833.6 5860.4 5862.8 4183.5 5686.6 6178.3 6440.5 6465.4 6373.4 6382.2 6391.3 6397.5 6411.4 7060.3 7341.2 7345.6 7433.7 7479.7 6997.3 7035.5 7068.3 7116.1 7163.5 27480.6 28187.6 28502.0 28730.0 29240.3 2314.7 2357.7 2359.4 2726.3 2815.0 14912.9 15703.2 15881.1 16165.6 16269.0 1865.5 1895.7 1941.8 1984.3 2194.1 106370.5 112067.4 113315.0 113463.0 113685.0 20078.0 20218.0 20476.3 20611.9 20648.6 28764.9 28779.7 28997.6 29555.4 29613.7 9551.4 10587.8 10616.1 11042.2 11116.2 9297.3 9310.3 9340.6 9387.6 9445.4 9047.4 9138.7 9184.5 9215.2 9216.2 1882.7 1925.7 1966.6 2015.6 3769.4 906.2 918.2 955.5 1007.2 1072.4 17527.3 17848.8 17861.0 19253.2 20824.7 822.3 981.6 981.6 996.2 1043.6 9382.0 11043.9 11077.3 11118.7 11167.2 549749.3 586554.1 600554.0 601125.0 624874.0 107059.5 108176.9 110749.8 113529.0 118932.4 1027.7 1031.6 1041.2 1071.6 1080.3 12919.3 14764.0 16355.8 16590.3 17711.9 42733.6 45273.0 47307.0 52198.7 52305.7 70494.0 72373.0 72778.3 73745.6 74507.0 7571.1 7585.8 7692.5 7733.7 7856.4 10589.7 12016.6 12251.1 12398.6 12406.2 10119.5 10379.3 10429.9 10612.0 10658.2 9196.0 9669.6 10033.0 10291.4 10352.4 10034.8 10281.9 10319.0 10502.3 11092.9 6531.9 7312.9 7670.9 7684.9 7817.1 9409.9 10699.1 10708.0 10793.7 10953.9 17:13:22 INFO - PROCESS | 1675 | 17:13:22 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:6031.36 Median:5474.58 stddev:3181.36 (58.1%) stddev-sans-first:3172.83 17:13:22 INFO - PROCESS | 1675 | Values: 1597.3 1605.3 1920.1 2005.9 2006.2 7981.3 8368.4 8888.4 9084.8 9119.3 8665.2 8691.0 8780.4 8814.9 8899.6 2422.2 2442.1 2461.8 2467.3 2475.7 2413.7 2447.7 2458.0 2466.5 2468.5 2344.4 2427.0 2448.6 2470.6 2478.6 2444.7 2450.7 2471.5 2486.5 2487.1 2296.1 2352.2 2358.6 2359.8 2424.9 8809.6 8962.5 9014.0 9042.6 9043.2 5464.0 5474.3 5486.3 5494.5 5538.1 3034.8 3579.6 3658.8 3670.9 3684.4 960.8 1008.7 1016.2 1042.0 1043.1 8787.0 10506.5 11695.1 11975.3 12049.5 4903.9 4932.2 5028.1 5038.8 5048.7 10042.5 10129.3 10155.0 10180.0 10266.8 5474.8 5506.8 5570.2 5620.8 5642.8 4489.3 4968.3 4985.3 5048.7 5104.0 3972.4 4023.1 4025.7 4029.1 4104.7 1335.7 1347.0 1352.4 1353.0 1361.9 1082.2 1088.4 1147.7 1208.1 1383.5 8140.8 8145.9 8194.7 8217.3 8245.9 518.3 525.5 531.2 531.6 533.0 6063.1 6113.5 6156.4 6162.3 6187.1 10492.4 10831.2 11040.7 11087.9 11104.9 10272.0 10451.7 10526.4 10563.2 11017.8 8341.2 8484.2 8507.3 8561.0 8574.3 7537.4 7945.0 7965.2 7984.5 8032.6 9369.5 9649.2 9728.9 9731.1 9843.3 7936.3 9566.3 9952.4 9968.9 10022.2 6827.5 6899.2 7116.9 7348.4 7585.9 8329.1 8362.1 8407.0 8424.4 8426.5 6726.7 7229.6 7426.3 7482.5 7583.2 7316.9 7346.5 7440.9 7444.4 7547.5 6636.8 7392.3 7667.7 7680.2 7757.8 6622.2 6628.6 6704.9 6784.5 6936.1 7051.3 7173.1 7228.8 7238.8 7268.1 17:13:22 INFO - PROCESS | 1675 | 17:13:22 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:5910.92 Median:6716.80 stddev:1926.53 (28.7%) stddev-sans-first:1885.45 17:13:22 INFO - PROCESS | 1675 | Values: 306.5 329.2 332.6 338.2 339.5 6843.1 6868.4 6885.0 6898.3 6912.8 6010.5 6224.2 6790.0 6800.9 6813.3 4646.6 4827.7 4976.7 4995.0 5051.9 4586.3 4703.9 4964.3 4981.0 5046.2 4864.4 4987.8 5006.9 5013.8 5037.0 5014.6 5016.7 5021.3 5033.5 5054.6 4288.0 4297.5 4311.9 4326.9 4328.5 6203.1 6462.7 6510.5 6551.6 6573.3 5790.9 5832.4 5845.1 5853.9 5854.2 7129.4 7259.3 7286.3 7288.5 7322.7 3797.4 4064.4 4602.0 4637.7 4652.5 7560.4 7588.9 7691.2 7695.7 7705.3 4462.5 4682.4 4699.0 4712.1 4718.2 4751.0 4784.9 4788.9 4791.7 4797.4 5758.3 5768.1 5772.7 5785.4 5787.1 7224.7 7240.5 7269.9 7271.5 7298.8 1652.3 1676.4 1679.1 1682.5 1685.5 1020.9 1060.3 1068.4 1073.7 1081.3 6691.5 6709.9 6723.7 6737.0 6750.3 6082.5 7207.0 7537.4 7584.0 7588.1 4845.8 6554.6 6656.0 6750.8 6799.8 3536.7 3644.7 3755.5 3942.6 4033.7 7944.5 7960.2 7989.2 7991.3 8000.0 7520.6 7894.3 7895.0 7905.4 7907.2 6398.9 6741.4 7759.8 7915.6 7985.1 7612.1 7615.2 7624.5 7626.8 7633.5 7437.0 7441.3 7466.5 7470.7 7483.4 7612.5 7912.5 7973.0 7974.3 8042.5 4704.4 4732.0 4733.8 4735.8 4750.3 7555.2 7584.7 7602.3 7611.2 7613.6 7195.5 7226.7 7248.5 7266.1 7292.3 5955.1 6573.5 6923.7 7301.9 7370.7 7119.2 7124.7 7185.3 7185.7 7196.5 7288.5 7317.6 7317.6 7350.8 7377.9 7125.0 7141.3 7154.6 7176.7 7181.5 17:13:22 INFO - PROCESS | 1675 | 17:13:22 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:17636.30 Median:611.99 stddev:24579.36 (4016.3%) stddev-sans-first:24615.08 17:13:22 INFO - PROCESS | 1675 | Values: 614.2 715.4 745.7 755.9 762.5 14897.6 14958.3 15198.7 15415.4 15535.9 14123.7 14289.1 14321.9 14331.6 14336.1 743.5 908.8 924.9 926.4 933.6 902.3 903.1 904.5 939.5 945.1 979.9 993.7 998.8 1006.5 1007.5 977.9 996.9 997.4 999.4 1000.3 723.0 728.2 733.5 742.2 742.4 14844.6 14849.9 14876.3 14883.6 15135.8 12965.4 12980.4 12992.9 13101.7 13147.4 9945.2 10111.9 10204.9 10240.6 10537.5 3479.3 3504.4 3513.5 3557.2 3619.9 60149.0 60546.7 63449.0 64124.0 84068.0 9467.6 9550.0 9590.5 9603.8 9826.8 17875.6 22192.9 22557.2 22665.2 22668.1 7564.9 7675.4 7707.0 7783.3 7849.2 3437.8 4126.7 4144.6 4161.6 4169.2 3018.8 3734.9 3747.2 3774.8 3777.8 547.8 639.4 659.8 665.2 694.2 532.0 572.7 598.4 609.8 614.8 6437.8 8140.5 8390.1 8417.6 8438.8 575.6 592.4 592.5 595.8 628.5 3737.4 3801.5 3885.3 3905.5 3963.2 89521.6 90119.0 91009.0 91450.0 91549.5 70657.6 73258.3 73629.6 76403.0 77346.0 66432.0 67848.0 69077.0 69749.0 71190.6 7729.6 7737.8 7811.0 7943.4 7962.4 47873.8 49854.8 50224.0 51289.7 51459.2 66673.0 69992.0 70061.6 70652.0 71224.6 8904.5 10141.2 10256.5 10366.4 10413.0 10606.5 10849.8 11010.0 11135.4 11435.5 10312.7 10430.2 10443.9 10702.6 10726.0 10468.2 10680.8 10774.2 11003.7 11300.8 9863.7 10050.7 10124.5 10126.6 10246.3 8631.3 8681.2 8836.5 9061.8 9126.1 8653.2 8905.3 8947.0 9078.2 9112.0 17:13:22 INFO - PROCESS | 1675 | -------- Summary: end -------- 17:13:22 INFO - PROCESS | 1675 | 17:13:22 INFO - TEST-INFO | 1675: exit 0 17:13:22 INFO - TEST-OK | dromaeo_css | took 1111925ms 17:13:22 INFO - TEST-START | kraken 17:13:22 INFO - operating with platform_type : mac_ 17:13:22 INFO - Initialising browser for kraken test... 17:13:22 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpBu4vfS/profile http://localhost:49270/getInfo.html) 17:13:25 INFO - PROCESS | 1683 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:13:25 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 17:13:25 INFO - PROCESS | 1683 | colorDepth:24 17:13:25 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 17:13:25 INFO - PROCESS | 1683 | __metrics 17:13:25 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 17:13:26 INFO - TEST-INFO | 1683: exit 0 17:13:26 INFO - Browser initialized. 17:13:26 INFO - Running cycle 1/1 for kraken test... 17:13:26 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpBu4vfS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:38 INFO - PROCESS | 1686 | RSS: Main: 258109440 17:13:38 INFO - PROCESS | 1686 | 17:13:40 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 17:13:41 INFO - PROCESS | 1686 | RSS: Main: 270557184 17:13:41 INFO - PROCESS | 1686 | 17:13:44 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 17:13:44 INFO - PROCESS | 1686 | RSS: Main: 278122496 17:13:44 INFO - PROCESS | 1686 | 17:13:48 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 17:13:49 INFO - PROCESS | 1686 | RSS: Main: 280776704 17:13:49 INFO - PROCESS | 1686 | 17:13:50 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 17:13:51 INFO - PROCESS | 1686 | RSS: Main: 282791936 17:13:51 INFO - PROCESS | 1686 | 17:13:53 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:13:54 INFO - PROCESS | 1686 | RSS: Main: 283459584 17:13:54 INFO - PROCESS | 1686 | 17:13:57 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 17:13:57 INFO - PROCESS | 1686 | RSS: Main: 285569024 17:13:57 INFO - PROCESS | 1686 | 17:14:00 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 17:14:01 INFO - PROCESS | 1686 | RSS: Main: 285282304 17:14:01 INFO - PROCESS | 1686 | 17:14:04 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 17:14:05 INFO - PROCESS | 1686 | RSS: Main: 285708288 17:14:05 INFO - PROCESS | 1686 | 17:14:06 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:14:07 INFO - PROCESS | 1686 | RSS: Main: 283922432 17:14:07 INFO - PROCESS | 1686 | 17:14:08 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:14:09 INFO - PROCESS | 1686 | RSS: Main: 284127232 17:14:09 INFO - PROCESS | 1686 | 17:14:11 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:14:12 INFO - PROCESS | 1686 | RSS: Main: 285057024 17:14:12 INFO - PROCESS | 1686 | 17:14:15 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:14:15 INFO - PROCESS | 1686 | RSS: Main: 285134848 17:14:15 INFO - PROCESS | 1686 | 17:14:18 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:14:18 INFO - PROCESS | 1686 | RSS: Main: 285245440 17:14:18 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 17:14:20 INFO - PROCESS | 1686 | RSS: Main: 285577216 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | __start_tp_report 17:14:20 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 17:14:20 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 17:14:20 INFO - PROCESS | 1686 | |i|pagename|runs| 17:14:20 INFO - PROCESS | 1686 | |0;ai-astar;117;111;117;116;114;127;114;116;121;131 17:14:20 INFO - PROCESS | 1686 | |1;audio-beat-detection;157;134;167;191;135;178;132;115;164;141 17:14:20 INFO - PROCESS | 1686 | |2;audio-dft;170;273;194;215;238;274;283;223;201;201 17:14:20 INFO - PROCESS | 1686 | |3;audio-fft;75;77;73;112;56;57;59;59;121;59 17:14:20 INFO - PROCESS | 1686 | |4;audio-oscillator;84;104;139;79;82;82;119;85;97;166 17:14:20 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;90;87;90;88;91;109;115;133;76;130 17:14:20 INFO - PROCESS | 1686 | |6;imaging-darkroom;95;97;96;97;96;96;96;96;96;105 17:14:20 INFO - PROCESS | 1686 | |7;imaging-desaturate;92;93;124;105;151;130;149;82;155;151 17:14:20 INFO - PROCESS | 1686 | |8;json-parse-financial;56;57;55;57;57;55;57;62;58;56 17:14:20 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;68;68;74;70;73;76;69;68;67;69 17:14:20 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;96;100;107;87;85;85;84;86;86;83 17:14:20 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;130;131;113;134;135;153;129;140;134;135 17:14:20 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;136;142;145;141;139;163;181;161;143;131 17:14:20 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;68;68;69;66;68;67;68;68;69;67 17:14:20 INFO - PROCESS | 1686 | __end_tp_report 17:14:20 INFO - PROCESS | 1686 | __start_cc_report 17:14:20 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,974 17:14:20 INFO - PROCESS | 1686 | __end_cc_report 17:14:20 INFO - PROCESS | 1686 | __startTimestamp1458692060754__endTimestamp 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | ------- Summary: start ------- 17:14:20 INFO - PROCESS | 1686 | Number of tests: 14 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:118.40 Median:117.00 stddev:6.22 (5.3%) stddev-sans-first:6.58 17:14:20 INFO - PROCESS | 1686 | Values: 117.0 111.0 117.0 116.0 114.0 127.0 114.0 116.0 121.0 131.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:160.50 stddev:23.78 (14.8%) stddev-sans-first:25.14 17:14:20 INFO - PROCESS | 1686 | Values: 157.0 134.0 167.0 191.0 135.0 178.0 132.0 115.0 164.0 141.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:227.20 Median:230.50 stddev:38.63 (16.8%) stddev-sans-first:34.99 17:14:20 INFO - PROCESS | 1686 | Values: 170.0 273.0 194.0 215.0 238.0 274.0 283.0 223.0 201.0 201.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:74.80 Median:59.00 stddev:23.44 (39.7%) stddev-sans-first:24.86 17:14:20 INFO - PROCESS | 1686 | Values: 75.0 77.0 73.0 112.0 56.0 57.0 59.0 59.0 121.0 59.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:82.00 stddev:29.24 (35.7%) stddev-sans-first:30.13 17:14:20 INFO - PROCESS | 1686 | Values: 84.0 104.0 139.0 79.0 82.0 82.0 119.0 85.0 97.0 166.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:100.90 Median:87.50 stddev:19.60 (22.4%) stddev-sans-first:20.39 17:14:20 INFO - PROCESS | 1686 | Values: 90.0 87.0 90.0 88.0 91.0 109.0 115.0 133.0 76.0 130.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:96.00 stddev:2.87 (3.0%) stddev-sans-first:2.95 17:14:20 INFO - PROCESS | 1686 | Values: 95.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 105.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:123.20 Median:153.00 stddev:28.25 (18.5%) stddev-sans-first:27.62 17:14:20 INFO - PROCESS | 1686 | Values: 92.0 93.0 124.0 105.0 151.0 130.0 149.0 82.0 155.0 151.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:2.00 (3.5%) stddev-sans-first:2.09 17:14:20 INFO - PROCESS | 1686 | Values: 56.0 57.0 55.0 57.0 57.0 55.0 57.0 62.0 58.0 56.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:69.50 stddev:3.05 (4.4%) stddev-sans-first:3.13 17:14:20 INFO - PROCESS | 1686 | Values: 68.0 68.0 74.0 70.0 73.0 76.0 69.0 68.0 67.0 69.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:85.50 stddev:8.17 (9.6%) stddev-sans-first:8.36 17:14:20 INFO - PROCESS | 1686 | Values: 96.0 100.0 107.0 87.0 85.0 85.0 84.0 86.0 86.0 83.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:134.50 stddev:9.92 (7.4%) stddev-sans-first:10.45 17:14:20 INFO - PROCESS | 1686 | Values: 130.0 131.0 113.0 134.0 135.0 153.0 129.0 140.0 134.0 135.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:144.00 stddev:15.33 (10.6%) stddev-sans-first:15.61 17:14:20 INFO - PROCESS | 1686 | Values: 136.0 142.0 145.0 141.0 139.0 163.0 181.0 161.0 143.0 131.0 17:14:20 INFO - PROCESS | 1686 | 17:14:20 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 17:14:20 INFO - PROCESS | 1686 | Values: 68.0 68.0 69.0 66.0 68.0 67.0 68.0 68.0 69.0 67.0 17:14:20 INFO - PROCESS | 1686 | -------- Summary: end -------- 17:14:20 INFO - PROCESS | 1686 | 17:14:21 INFO - TEST-INFO | 1686: exit 0 17:14:21 INFO - TEST-OK | kraken | took 58876ms 17:14:21 INFO - SUITE-END | took 1170s 17:14:21 INFO - Completed test suite (00:19:31) 17:14:21 INFO - javascript benchmark 17:14:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3335.9666403335964, 3460.3079384123166, 3480.965190348096, 3512.490688850118, 3539.309834582254, 5611.102223644223, 5749.913751293729, 5782.595218334718, 5804.82585522435, 5825.883482330356, 5558.221848941142, 5616.269884914956, 5682.460166284207, 5706.65760054397, 5846.181534585162, 5144.485551444854, 5192.247124167013, 5195.896082078356, 5225.163973764198, 5305.761240744157, 5233.031889100528, 5243.764030618612, 5258.842234732964, 5271.341082364705, 5301.310829592167, 4672.813087476497, 5076.771545280471, 5209.60927930403, 5231.110711179071, 5285.814996475144, 5134.460881607415, 5161.509656582619, 5171.0, 5171.948280517222, 5179.300794392784, 5027.0, 5097.49025097491, 5110.66780659256, 5148.9702059588235, 5209.088409528317, 5504.926539324833, 5626.7186640668215, 5660.179274005246, 5672.205891175238, 5676.205331253628, 6182.876342473125, 6217.098520714516, 6280.811575652692, 6298.496120310364, 6298.716557754912, 6143.293521245069, 6157.538184636125, 6179.0422484514975, 6205.627662340274, 6235.688215589203, 5804.361520232771, 5809.796657116981, 5813.924423981534, 5815.709214539298, 5846.064629659234, 6249.343818899041, 6267.2165979252595, 6275.278342990615, 6277.937220627827, 6302.0, 5947.732352044169, 6097.222222222223, 6129.969350153221, 6185.969070154621, 6215.160953271341, 6100.664463454464, 6139.216166136444, 6224.533160013018, 6254.186955695822, 6281.497480201573, 6208.50331973441, 6218.253809542884, 6289.245290565162, 6295.496360291166, 6302.779402720975, 6100.786472473442, 6149.477294430024, 6172.351903050205, 6201.96899015502, 6273.498120150377, 4881.148599003121, 4894.486078961658, 4900.681455705368, 4916.483769204254, 4918.262260660858, 4182.686298527623, 4419.138268037702, 4419.558044195554, 4422.380866678667, 4432.977835110803, 5537.058700021006, 5562.332520097614, 5645.98372292983, 5705.828825135252, 5742.310922689304, 6247.687615619201, 6250.15622890913, 6253.499720022387, 6264.404881536247, 6267.623942563369, 5590.468905453975, 5761.53907687384, 5789.739461724233, 5805.042168042226, 5821.854453638608, 5306.575473962151, 5371.650842695212, 5377.784888604412, 5381.0852155133725, 5449.863753406117, 6330.525210609223, 6350.618962862243, 6365.872682546323, 6374.426301632875, 6377.4579160771855, 5348.652337598043, 5505.394406615349, 6147.72335244924, 6281.905771413341, 6302.810915672537, 5165.483451654804, 6322.3045464997895, 6328.46208072319, 6330.968345158245, 6334.0, 6115.0, 6118.969405152946, 6178.41305076017, 6180.0, 6189.752409903554, 4947.911459478909, 6058.4244496772735, 6064.514838812973, 6154.876902461836, 6185.288691800501, 5994.970025149846, 6035.336113027475, 6094.457644858721, 6109.254396435016, 6115.240341084353, 6127.754889804358, 6133.877322453615, 6196.411340922786, 6212.627242365473, 6229.56393052482, 5818.6217895836635, 5832.358440571449, 6066.1204125402455, 6097.817065488042, 6133.815985520441, 5384.246205531151, 5555.055640541199, 6102.14613164857, 6157.076438534255, 6179.3820617937845, 6032.668203248688, 6034.517238620988, 6041.9395806041375, 6046.274447066205, 6055.455009049207], "unit": "score", "name": "dojo.html", "value": 5674.408023470409}, {"lowerIsBetter": false, "replicates": [482.9903401931961, 541.2936118365533, 558.4917724870369, 573.6099452372385, 596.8478038100284, 30012.849935750317, 38401.61598384015, 38805.417918731204, 38835.0, 38876.22247555051, 40318.798406008005, 40365.789026329185, 40973.565925192626, 41084.0, 41094.383584246185, 9394.953025234881, 9495.620175193018, 9554.283428742838, 9625.374350667184, 9662.71011869645, 9342.532873356338, 9558.761030974212, 9560.665376711817, 9583.904160958406, 9608.375455595398, 9489.240860731159, 9548.331616786827, 9608.663696770614, 9609.375390599624, 9623.989481104489, 9457.763555911088, 9507.477088760115, 9542.856857147113, 9604.519774011307, 9607.855882161773, 9505.904940950571, 9624.47065411402, 9646.517674116267, 9654.22766178704, 9680.177184939288, 29519.262018449495, 32998.34003319944, 38453.61546384556, 39634.40548391776, 39680.20639587192, 3206.2625596112794, 3217.067050555336, 3220.066180807563, 3264.508928571439, 3484.285721427101, 24150.637740433907, 26197.0, 28445.431091378057, 29092.41815163706, 29197.0, 2110.6095372356162, 2671.6526851509375, 2750.8624568771484, 2810.367667274847, 2818.5067613167816, 475530.0, 537357.0, 537387.999999996, 545484.5451545473, 545623.0, 67237.0, 67555.64888702199, 68006.29984250433, 68228.6588567054, 68402.0, 71953.56092878217, 73540.63229683817, 73950.0, 74421.25578744251, 74748.0, 17051.829481705023, 17193.7420938686, 17326.65346693059, 17334.47996560105, 17449.651006980042, 12599.118061735591, 12916.22502649844, 12918.41867115982, 13023.413946372437, 13035.674108147372, 22201.555968880533, 22290.777092229193, 22370.217042403765, 22418.0, 22549.66175507369, 9469.857952130724, 9475.00512446197, 9582.233421326277, 9585.0, 9611.038896110473, 992.2657233647193, 1026.8665073540542, 1060.3054998975683, 1126.3917484558247, 1155.3356819828464, 29632.962846300277, 29636.851815741215, 29971.95098171597, 30000.69999299979, 30145.69854301429, 961.2166084640995, 966.5843687214425, 986.8174387738292, 1054.262016588376, 1147.8450409194652, 13000.674983125498, 14226.928865355814, 14561.635959101108, 14563.0, 14781.704365912621, 479725.0, 485977.0, 490008.0, 490713.0, 491463.0, 58880.0, 58935.70532147398, 59930.700346497986, 60457.093143602884, 60662.69668651628, 1443.5741456270425, 1467.948621798232, 1473.963150921214, 1486.9628259293604, 1491.1798510819006, 28264.0, 28359.85820070969, 28499.43001139924, 28512.85743571269, 28841.567376489787, 48680.0, 49835.0, 50098.49901501084, 50319.0, 50462.49537504578, 427620.0, 436341.0, 437873.970082399, 438846.0, 439935.0, 34191.65808341885, 44390.556094438645, 45136.32295515504, 45267.86830329136, 46068.769656151504, 44391.33412998743, 44407.555924441636, 44430.0, 44468.924451060666, 44876.0, 36301.91094267176, 36662.8166859164, 36767.0, 37094.25811483809, 37149.69976050825, 37780.62219377881, 37889.0, 37978.24043519169, 38606.0, 38697.61302387053, 32804.0, 37242.0, 38216.66241681528, 38484.42273365846, 38853.41719874261, 27892.58161127544, 32704.34591308208, 32969.0, 33400.66599334073, 34249.97250082502, 24913.0, 25233.49533009366, 25313.240602781945, 25354.746452535237, 25470.108546200794], "unit": "score", "name": "ext.html", "value": 20027.904916122287}, {"lowerIsBetter": false, "replicates": [351.3482489981085, 356.37812018028546, 362.2627952117441, 373.3764613096129, 380.4407520944211, 16113.67772644548, 19676.70484942727, 21004.159833606656, 21124.943752812374, 21149.471263218427, 17445.651086978254, 20243.59512809743, 20872.89563552184, 21040.158393664275, 21499.355019349405, 4840.6369522285795, 5617.606767526265, 5833.562482813784, 5860.355360910296, 5862.765489380419, 4183.497980242375, 5686.573506986972, 6178.258608966908, 6440.4847612190915, 6465.3534646535445, 6373.394527519901, 6382.170317858695, 6391.265004524493, 6397.456216221627, 6411.422971932525, 7060.3292687194635, 7341.1557670868, 7345.55926644403, 7433.665485053131, 7479.7382091626805, 6997.335253150943, 7035.5075144739885, 7068.328508791708, 7116.074910261685, 7163.534370265968, 27480.58779118315, 28187.617485901617, 28502.0, 28730.0, 29240.268993275127, 2314.664373665809, 2357.6934998450265, 2359.3629719975684, 2726.2502811726936, 2815.0428854189468, 14912.925435372754, 15703.214839257991, 15881.126538040404, 16165.595860103474, 16269.023858568524, 1865.486991077451, 1895.6966885298286, 1941.7864034956144, 1984.335247692025, 2194.1004188282727, 106370.46814765877, 112067.43966280116, 113315.0, 113463.0, 113685.0, 20078.0, 20218.0, 20476.283330083377, 20611.896940515202, 20648.58702825935, 28764.85617571899, 28779.712202878123, 28997.56503652447, 29555.408891822044, 29613.703862961527, 9551.42691438516, 10587.84118238227, 10616.097631701237, 11042.227044106836, 11116.220944763809, 9297.302702297355, 9310.348275620641, 9340.57967391469, 9387.57755900986, 9445.433274003582, 9047.366684332164, 9138.725838224864, 9184.49485278316, 9215.216706579882, 9216.216621587106, 1882.7081802320663, 1925.6822624266838, 1966.606678664273, 2015.6069566434405, 3769.3991146109097, 906.2387594420718, 918.2103391083663, 955.47926380123, 1007.2445665750687, 1072.367303291062, 17527.29890804379, 17848.75058745875, 17861.0, 19253.22987080501, 20824.687629685566, 822.2722890242179, 981.5926390547985, 981.6024510073431, 996.2378780233128, 1043.5564884923876, 9382.0, 11043.889561104446, 11077.279976801483, 11118.666440006813, 11167.218294719454, 549749.2512537412, 586554.1344586585, 600554.0, 601125.0, 624874.0, 107059.46470267599, 108176.91823081826, 110749.78500430107, 113529.0, 118932.40533797276, 1027.7071034755209, 1031.6492392586406, 1041.1930753665818, 1071.6195750508614, 1080.3355936099242, 12919.289439080942, 14763.966522343762, 16355.754663679816, 16590.336386544404, 17711.937283763014, 42733.57266427296, 45273.0, 47307.0, 52198.73900630473, 52305.73847130892, 70494.0, 72373.0, 72778.27221727715, 73745.6312718433, 74507.0, 7571.129320128035, 7585.772426827204, 7692.461527693232, 7733.651985660546, 7856.410769192447, 10589.682309530726, 12016.63950081499, 12251.08116891219, 12398.5660501882, 12406.193597416139, 10119.494025298558, 10379.325343852626, 10429.9478502607, 10612.0449159576, 10658.200634952254, 9196.0, 9669.597908303398, 10033.046860548237, 10291.35291601598, 10352.430616316175, 10034.849477257701, 10281.897181028095, 10319.0, 10502.317349372266, 11092.889071109186, 6531.934680653323, 7312.866505691626, 7670.923290767244, 7684.923150768421, 7817.061952565501, 9409.905900941178, 10699.090577301016, 10708.0, 10793.67618971432, 10953.890461095287], "unit": "score", "name": "jquery.html", "value": 10281.516294293222}, {"lowerIsBetter": false, "replicates": [1597.3291217688572, 1605.325763179464, 1920.1071501751683, 2005.8696184747998, 2006.1774672384315, 7981.321587665056, 8368.414211005233, 8888.422252553588, 9084.772880677987, 9119.270458363331, 8665.176808203227, 8690.956545217281, 8780.385373023892, 8814.86777698335, 8899.555022248878, 2422.2127808462233, 2442.084218418098, 2461.8153638477097, 2467.3214865911928, 2475.6905386826647, 2413.703607578513, 2447.730749617541, 2457.9631305530434, 2466.469709012562, 2468.5309791139716, 2344.3787396339985, 2426.954172513502, 2448.5959816630325, 2470.6170543565777, 2478.62820576914, 2444.6577479152934, 2450.7181674107437, 2471.456279618481, 2486.5151295497385, 2487.1170734389393, 2296.0700916128994, 2352.1532248390567, 2358.6462030695534, 2359.7522260162777, 2424.9272521824373, 8809.64761409543, 8962.507062111581, 9013.954930225373, 9042.638294468214, 9043.231325337354, 5464.0, 5474.315710536183, 5486.31421072366, 5494.5054945054735, 5538.0585300499015, 3034.833084180369, 3579.588347340063, 3658.762180458262, 3670.871519496805, 3684.3552378333684, 960.846264597661, 1008.6822650864954, 1016.2327442780727, 1041.9583216671324, 1043.12377602814, 8786.956065219696, 10506.52720627566, 11695.1228657851, 11975.281483111128, 12049.518019279218, 4903.87740306488, 4932.161532539477, 5028.120078986236, 5038.773255203525, 5048.747562621854, 10042.548085336177, 10129.290949633601, 10154.984501549934, 10179.98200179976, 10266.794664106676, 5474.835754927359, 5506.807261745819, 5570.164475328733, 5620.775168993277, 5642.802501912413, 4489.326601009875, 4968.30443737877, 4985.252212168131, 5048.747562621854, 5104.03023425548, 3972.3644216925154, 4023.1350259694304, 4025.7383270087353, 4029.073313137995, 4104.692148088905, 1335.6794369351285, 1347.036868638928, 1352.4454973460834, 1352.9594112176453, 1361.9319034048258, 1082.1721383141903, 1088.4068182840372, 1147.6786499780076, 1208.1180738061264, 1383.4535358533324, 8140.75577732669, 8145.877811832709, 8194.713185038496, 8217.260446559838, 8245.876311855327, 518.271828081546, 525.5086494128003, 531.2191079113696, 531.5773959702046, 533.0059439146042, 6063.120847477091, 6113.510919126459, 6156.445919867144, 6162.322144564095, 6187.071939209065, 10492.4229167395, 10831.241813073168, 11040.723981900517, 11087.944560277147, 11104.944475277573, 10272.024157705006, 10451.738706532245, 10526.368417894952, 10563.154947604173, 11017.83473247902, 8341.16588341161, 8484.236418722345, 8507.27688146502, 8561.0, 8574.271186949054, 7537.397008239437, 7945.046594408708, 7965.203479651988, 7984.481008734414, 8032.558209298545, 9369.484678342484, 9649.228061755182, 9728.9027109728, 9731.12419882214, 9843.261755368232, 7936.2857342839425, 9566.282528810229, 9952.402855828674, 9968.850467242852, 10022.24833137503, 6827.52207345481, 6899.17209934811, 7116.857662846611, 7348.375388092072, 7585.886211706939, 8329.083800782031, 8362.121977192308, 8407.0, 8424.368172386972, 8426.452280601741, 6726.6636668167375, 7229.566226026455, 7426.331630153312, 7482.476226664081, 7583.165851756192, 7316.926830731624, 7346.501559656121, 7440.921066445443, 7444.404447644067, 7547.471676982558, 6636.800895973129, 7392.334689877936, 7667.731629392944, 7680.155182929761, 7757.806054848674, 6622.238442579165, 6628.635425051669, 6704.932950670431, 6784.457243420416, 6936.0636314098965, 7051.259617740268, 7173.1392232932385, 7228.819279518054, 7238.782836514913, 7268.127824661075], "unit": "score", "name": "mootools.html", "value": 4840.229486711758}, {"lowerIsBetter": false, "replicates": [306.50805457241125, 329.17213208779924, 332.6025399647422, 338.2170275811497, 339.5382280099065, 6843.076184715062, 6868.381845633892, 6885.0, 6898.310168983099, 6912.758053468124, 6010.489108425778, 6224.23021755319, 6789.966050169743, 6800.8979865301935, 6813.284605116466, 4646.581807637312, 4827.734474603895, 4976.726280054613, 4994.97502512487, 5051.939092790519, 4586.312053192015, 4703.905921881577, 4964.280179374006, 4981.0037992401485, 5046.21783623539, 4864.416270047582, 4987.800487980477, 5006.949930500685, 5013.799448022075, 5036.9926014797, 5014.5737612303, 5016.724080175589, 5021.27191557224, 5033.496650334974, 5054.570361519293, 4288.0351920817875, 4297.484301883763, 4311.892202694927, 4326.939899724556, 4328.480582330109, 6203.131561581382, 6462.709178086998, 6510.5117116216, 6551.606903585753, 6573.276939536647, 5790.913136302959, 5832.387599302097, 5845.09401042839, 5853.88292234153, 5854.151148083547, 7129.429645628389, 7259.346658800733, 7286.307800758919, 7288.489805713602, 7322.707091716325, 3797.3544497435228, 4064.4309796628495, 4601.964557974463, 4637.698549594265, 4652.464966528859, 7560.3573696236435, 7588.875114967818, 7691.153973062958, 7695.730649427299, 7705.345045671124, 4462.464504259509, 4682.4381074271305, 4699.0, 4712.104700107037, 4718.150732868048, 4750.976245118753, 4784.928226076611, 4788.904221915612, 4791.688540244873, 4797.424309082932, 5758.280214973129, 5768.134779782982, 5772.6536407815665, 5785.363610002896, 5787.074068149076, 7224.711011559584, 7240.52936559122, 7269.890951635624, 7271.490995630361, 7298.781036568911, 1652.339064374236, 1676.3629820668068, 1679.0681171949684, 1682.512071499276, 1685.4690772406652, 1020.9132223760915, 1060.316096118015, 1068.3750006246432, 1073.7476692977143, 1081.324172392255, 6691.498137639696, 6709.899351509731, 6723.697433615499, 6736.955771855272, 6750.291219421988, 6082.543809214327, 7206.963965180141, 7537.397008239437, 7584.0, 7588.089429268523, 4845.75771211438, 6554.606723596599, 6655.96832490955, 6750.831229219309, 6799.762008329783, 3536.681698647134, 3644.653757892996, 3755.530558680165, 3942.56631770505, 4033.69747268956, 7944.483608565425, 7960.243776841191, 7989.201079892081, 7991.320737737357, 8000.0, 7520.6239688015385, 7894.328982036476, 7894.960525197337, 7905.367570594339, 7907.169747176464, 6398.936010639834, 6741.426978706865, 7759.844803104019, 7915.643796029078, 7985.08171560278, 7612.1246056704185, 7615.200403957505, 7624.504407213513, 7626.8093297668, 7633.465657403928, 7436.996005539183, 7441.255874412515, 7466.477346585904, 7470.738524151629, 7483.438742094474, 7612.505187162817, 7912.525248485109, 7973.0, 7974.322182614543, 8042.477238979448, 4704.364910737144, 4731.976340118277, 4733.763311834464, 4735.810567577396, 4750.311204875343, 7555.168931417649, 7584.734534291273, 7602.277783610548, 7611.238876112345, 7613.619319033915, 7195.532290401107, 7226.74706385274, 7248.456365772483, 7266.091738532684, 7292.270772922665, 5955.106733989936, 6573.502069213669, 6923.723051077901, 7301.853962920818, 7370.705171793283, 7119.181294151239, 7124.715011399486, 7185.317394847481, 7185.748498802517, 7196.4962452627815, 7288.489805713549, 7317.560946343024, 7317.5609463432365, 7350.816229594303, 7377.852442951218, 7125.0, 7141.250168732416, 7154.642267886689, 7176.7488137914925, 7181.497295189495], "unit": "score", "name": "prototype.html", "value": 5262.475969630282}, {"lowerIsBetter": false, "replicates": [614.198470995351, 715.4062128433401, 745.7203548669249, 755.9092908850937, 762.5119923249118, 14897.627559311022, 14958.252087395615, 15198.696026079486, 15415.3833846646, 15535.912486125962, 14123.717525649481, 14289.142651440894, 14321.92839035806, 14331.64170895728, 14336.139831610084, 743.5204293230863, 908.7864351877304, 924.935254532183, 926.3515539122608, 933.5705575435273, 902.3187493442442, 903.0743487924897, 904.5025236120141, 939.492673956063, 945.0879900895634, 979.8971108033661, 993.6919554937992, 998.8152191844496, 1006.4565134827185, 1007.4861820471575, 977.9070988256104, 996.8853581838109, 997.3766396002499, 999.3654029691126, 1000.3347773730496, 722.989155162673, 728.2135293882594, 733.5048842031607, 742.1576510660385, 742.446877076576, 14844.554663360008, 14849.92575037118, 14876.256187190596, 14883.627909302246, 15135.848641513665, 12965.416556254897, 12980.396059309365, 12992.870071299261, 13101.672458188526, 13147.408366623526, 9945.15466185375, 10111.949440252825, 10204.897951020468, 10240.590376384936, 10537.473126343652, 3479.3041391721504, 3504.404251277289, 3513.49054387115, 3557.1818481749083, 3619.9276014479565, 60149.0, 60546.69726651339, 63449.048264276076, 64124.03813942748, 84068.0, 9467.621295148117, 9550.0, 9590.520473976274, 9603.807923841485, 9826.75433114178, 17875.553111172063, 22192.88903555472, 22557.210497632503, 22665.20671776513, 22668.093276269094, 7564.945757941657, 7675.424343174284, 7706.998090248232, 7783.260590243918, 7849.215078492105, 3437.8281085945605, 4126.71343874503, 4144.626983571493, 4161.583841615875, 4169.207850508394, 3018.83396413195, 3734.925301493955, 3747.1756213632957, 3774.7923864187183, 3777.773333599993, 547.8411260734422, 639.3702203329809, 659.7756762700704, 665.2416245480157, 694.2259380790483, 531.9679821146963, 572.6792995922214, 598.4255115089476, 609.7774312375951, 614.8134101184756, 6437.806865794034, 8140.470869393471, 8390.119037500974, 8417.621207045575, 8438.789030274293, 575.5711994563993, 592.4431034827248, 592.5259792166249, 595.842101843012, 628.4626644219218, 3737.4206997915367, 3801.5248093988253, 3885.289548481194, 3905.511811023622, 3963.2271707016853, 89521.55239223762, 90119.0, 91009.0, 91450.0, 91549.54225228964, 70657.64671176714, 73258.2674173262, 73629.6318518404, 76403.0, 77346.0, 66432.00351994723, 67848.0, 69076.96384554236, 69749.0, 71190.64404677943, 7729.613519324123, 7737.845243095219, 7811.0, 7943.4439589230515, 7962.363010959225, 47873.76063119801, 49854.75072624614, 50224.0, 51289.743551282, 51459.228111577606, 66672.9999050005, 69991.95012074924, 70061.64969175121, 70652.0, 71224.64387678029, 8904.510251936206, 10141.239407044353, 10256.461183246794, 10366.429846358222, 10413.0, 10606.454450931875, 10849.837252441062, 11010.0, 11135.3875536843, 11435.542578296774, 10312.742181445525, 10430.165586753194, 10443.94778026105, 10702.625408110678, 10725.981031801966, 10468.162546996375, 10680.786384272116, 10774.24580279373, 11003.669889903316, 11300.819460703467, 9863.654772082942, 10050.69847904564, 10124.493775311352, 10126.645567405105, 10246.333988290737, 8631.26634236097, 8681.175288347597, 8836.469811811312, 9061.77345566366, 9126.087391261086, 8653.221210091122, 8905.33210009239, 8947.0, 9078.228350590274, 9112.0], "unit": "score", "name": "yui.html", "value": 6790.760857085303}], "name": "dromaeo_css", "value": 7660.73982341595}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 111.0, 117.0, 116.0, 114.0, 127.0, 114.0, 116.0, 121.0, 131.0], "unit": "score", "name": "ai-astar", "value": 118.4}, {"lowerIsBetter": true, "replicates": [157.0, 134.0, 167.0, 191.0, 135.0, 178.0, 132.0, 115.0, 164.0, 141.0], "unit": "score", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [170.0, 273.0, 194.0, 215.0, 238.0, 274.0, 283.0, 223.0, 201.0, 201.0], "unit": "score", "name": "audio-dft", "value": 227.2}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 73.0, 112.0, 56.0, 57.0, 59.0, 59.0, 121.0, 59.0], "unit": "score", "name": "audio-fft", "value": 74.8}, {"lowerIsBetter": true, "replicates": [84.0, 104.0, 139.0, 79.0, 82.0, 82.0, 119.0, 85.0, 97.0, 166.0], "unit": "score", "name": "audio-oscillator", "value": 103.7}, {"lowerIsBetter": true, "replicates": [90.0, 87.0, 90.0, 88.0, 91.0, 109.0, 115.0, 133.0, 76.0, 130.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.9}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 105.0], "unit": "score", "name": "imaging-darkroom", "value": 97.0}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 124.0, 105.0, 151.0, 130.0, 149.0, 82.0, 155.0, 151.0], "unit": "score", "name": "imaging-desaturate", "value": 123.2}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 55.0, 57.0, 57.0, 55.0, 57.0, 62.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 74.0, 70.0, 73.0, 76.0, 69.0, 68.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.2}, {"lowerIsBetter": true, "replicates": [96.0, 100.0, 107.0, 87.0, 85.0, 85.0, 84.0, 86.0, 86.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.9}, {"lowerIsBetter": true, "replicates": [130.0, 131.0, 113.0, 134.0, 135.0, 153.0, 129.0, 140.0, 134.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.4}, {"lowerIsBetter": true, "replicates": [136.0, 142.0, 145.0, 141.0, 139.0, 163.0, 181.0, 161.0, 143.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 66.0, 68.0, 67.0, 68.0, 68.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1563.1000000000001}]} 17:14:22 INFO - Return code: 0 17:14:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:14:22 ERROR - # TBPL SUCCESS # 17:14:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:14:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:14:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:14:22 INFO - 2016-03-22 17:14:22.095 screenresolution[1691:10893] starting screenresolution argv=screenresolution get 17:14:22 INFO - 2016-03-22 17:14:22.098 screenresolution[1691:10893] Display 0: 1600x1200x32@60 17:14:22 INFO - 2016-03-22 17:14:22.104 screenresolution[1692:10896] starting screenresolution argv=screenresolution list 17:14:22 INFO - Available Modes on Display 0 17:14:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:14:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:14:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:14:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:14:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:14:22 INFO - Intel Iris: 17:14:22 INFO - Chipset Model: Intel Iris 17:14:22 INFO - Type: GPU 17:14:22 INFO - Bus: Built-In 17:14:22 INFO - VRAM (Dynamic, Max): 1536 MB 17:14:22 INFO - Vendor: Intel (0x8086) 17:14:22 INFO - Device ID: 0x0a2e 17:14:22 INFO - Revision ID: 0x0009 17:14:22 INFO - Displays: 17:14:22 INFO - Display: 17:14:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:14:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:14:22 INFO - Display Serial Number: 1600x1200 60 17:14:22 INFO - Main Display: Yes 17:14:22 INFO - Mirror: Off 17:14:22 INFO - Online: Yes 17:14:22 INFO - Rotation: Supported 17:14:22 INFO - Return code: 0 17:14:22 INFO - Running post-action listener: _resource_record_post_action 17:14:22 INFO - Running post-run listener: _resource_record_post_run 17:14:23 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 34262528; Write bytes: 709312512; Read time: 359; Write time: 2048 17:14:23 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395913728; Write bytes: 389719552; Read time: 29880; Write time: 698 17:14:23 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 32480768; Write bytes: 304396800; Read time: 340; Write time: 1316 17:14:23 INFO - Running post-run listener: _upload_blobber_files 17:14:23 INFO - Blob upload gear active. 17:14:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:14:23 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 17:14:23 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'] 17:14:23 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 17:14:24 INFO - (blobuploader) - INFO - Open directory for files ... 17:14:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:14:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:14:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:27 INFO - (blobuploader) - INFO - Done attempting. 17:14:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:14:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:14:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:30 INFO - (blobuploader) - INFO - Done attempting. 17:14:30 INFO - (blobuploader) - INFO - Iteration through files over. 17:14:30 INFO - Return code: 0 17:14:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:14:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:14:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15b2dbb272d941465656d6ed1e4a7866448ae5496ae7bd1fd176855e50677f4b504bff541fa8dee5bc084aa92c0960422f941b657e51b299caf3a4ff88bd85ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb40a167ddc573be2faa7cd272a84c3ebad8c09aac878013f5fb313b1175b67136f68222475af43d4c31a0f61f15319d620775ca69150d26a0291f9dcce7613b"} 17:14:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:14:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:14:30 INFO - Contents: 17:14:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15b2dbb272d941465656d6ed1e4a7866448ae5496ae7bd1fd176855e50677f4b504bff541fa8dee5bc084aa92c0960422f941b657e51b299caf3a4ff88bd85ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb40a167ddc573be2faa7cd272a84c3ebad8c09aac878013f5fb313b1175b67136f68222475af43d4c31a0f61f15319d620775ca69150d26a0291f9dcce7613b"} 17:14:30 INFO - Running post-run listener: copy_logs_to_upload_dir 17:14:30 INFO - Copying logs to upload dir... 17:14:30 INFO - mkdir: /builds/slave/test/build/upload/logs 17:14:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.813805 ========= master_lag: 7.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-03-22 17:14:37.532629) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 13 secs) (at 2016-03-22 17:14:37.536788) ========= 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.mC139zXAHg/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.IyBriXwBpB/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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/15b2dbb272d941465656d6ed1e4a7866448ae5496ae7bd1fd176855e50677f4b504bff541fa8dee5bc084aa92c0960422f941b657e51b299caf3a4ff88bd85ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb40a167ddc573be2faa7cd272a84c3ebad8c09aac878013f5fb313b1175b67136f68222475af43d4c31a0f61f15319d620775ca69150d26a0291f9dcce7613b"} build_url:https://queue.taskcluster.net/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/E6QfRllwSvKUO2vRn-8uCg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15b2dbb272d941465656d6ed1e4a7866448ae5496ae7bd1fd176855e50677f4b504bff541fa8dee5bc084aa92c0960422f941b657e51b299caf3a4ff88bd85ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb40a167ddc573be2faa7cd272a84c3ebad8c09aac878013f5fb313b1175b67136f68222475af43d4c31a0f61f15319d620775ca69150d26a0291f9dcce7613b"}' ========= master_lag: 13.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 13 secs) (at 2016-03-22 17:14:50.821062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-22 17:14:50.821446) ========= 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.mC139zXAHg/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.IyBriXwBpB/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.005097 ========= master_lag: 4.30 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-22 17:14:55.127456) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 17:14:55.127807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 17:14:56.058738) ========= ========= Total master_lag: 41.80 =========