builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0129 starttime: 1455627242.56 results: success (0) buildid: 20160216032350 builduid: c39347d2ca2647419ac9f2b37dad19be revision: 6ea654cad929c9bedd8a4161a182b6189fbeae6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.561542) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.561906) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.562177) ========= 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.PUW5zjGhQW/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.U5r2da56Ni/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005408 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.586153) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.586433) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.610947) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.611206) ========= 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.PUW5zjGhQW/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.U5r2da56Ni/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005385 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.660018) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.660405) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.660731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.661017) ========= 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.PUW5zjGhQW/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.U5r2da56Ni/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-16 04:54:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.1M=0.001s 2016-02-16 04:54:02 (10.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.236324 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.916110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.916617) ========= 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.PUW5zjGhQW/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.U5r2da56Ni/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.026334 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:02.965903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-16 04:54:02.966223) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6ea654cad929c9bedd8a4161a182b6189fbeae6a --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 6ea654cad929c9bedd8a4161a182b6189fbeae6a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PUW5zjGhQW/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.U5r2da56Ni/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-16 04:54:03,035 truncating revision to first 12 chars 2016-02-16 04:54:03,035 Setting DEBUG logging. 2016-02-16 04:54:03,035 attempt 1/10 2016-02-16 04:54:03,035 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6ea654cad929?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-16 04:54:03,691 unpacking tar archive at: fx-team-6ea654cad929/testing/mozharness/ program finished with exit code 0 elapsedTime=0.901152 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-16 04:54:04.025552) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:04.025940) ========= echo 6ea654cad929c9bedd8a4161a182b6189fbeae6a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6ea654cad929c9bedd8a4161a182b6189fbeae6a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PUW5zjGhQW/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.U5r2da56Ni/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 6ea654cad929c9bedd8a4161a182b6189fbeae6a program finished with exit code 0 elapsedTime=0.005858 script_repo_revision: '6ea654cad929c9bedd8a4161a182b6189fbeae6a' ========= master_lag: 0.32 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:04.348755) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:04.349063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 04:54:04.400566) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-02-16 04:54:04.401058) ========= /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.PUW5zjGhQW/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.U5r2da56Ni/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:54:04 INFO - MultiFileLogger online at 20160216 04:54:04 in /builds/slave/test 04:54:04 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 04:54:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:54:04 INFO - {'append_to_log': False, 04:54:04 INFO - 'base_work_dir': '/builds/slave/test', 04:54:04 INFO - 'blob_upload_branch': 'Fx-Team', 04:54:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:54:04 INFO - 'branch': 'Fx-Team', 04:54:04 INFO - 'buildbot_json_path': 'buildprops.json', 04:54:04 INFO - 'config_files': ('talos/mac_config.py',), 04:54:04 INFO - 'default_actions': ('clobber', 04:54:04 INFO - 'read-buildbot-config', 04:54:04 INFO - 'download-and-extract', 04:54:04 INFO - 'populate-webroot', 04:54:04 INFO - 'create-virtualenv', 04:54:04 INFO - 'install', 04:54:04 INFO - 'run-tests'), 04:54:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:54:04 INFO - 'download_minidump_stackwalk': True, 04:54:04 INFO - 'download_symbols': 'ondemand', 04:54:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:54:04 INFO - 'tooltool.py': '/tools/tooltool.py', 04:54:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:54:04 INFO - '/tools/misc-python/virtualenv.py')}, 04:54:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:54:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:54:04 INFO - 'installer_path': 'installer.exe', 04:54:04 INFO - 'log_level': 'info', 04:54:04 INFO - 'log_name': 'talos', 04:54:04 INFO - 'log_to_console': True, 04:54:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:54:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:54:04 INFO - 'opt_config_files': (), 04:54:04 INFO - 'pip_index': False, 04:54:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:54:04 INFO - 'cmd': ('bash', 04:54:04 INFO - '-c', 04:54:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:54:04 INFO - 'enabled': True, 04:54:04 INFO - 'halt_on_failure': False, 04:54:04 INFO - 'name': 'check_screen_resolution'},), 04:54:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:54:04 INFO - 'cmd': ('bash', 04:54:04 INFO - '-c', 04:54:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:54:04 INFO - 'enabled': True, 04:54:04 INFO - 'halt_on_failure': False, 04:54:04 INFO - 'name': 'check_screen_resolution'},), 04:54:04 INFO - 'run_cmd_checks_enabled': True, 04:54:04 INFO - 'sps_profile': False, 04:54:04 INFO - 'sps_profile_interval': 0, 04:54:04 INFO - 'suite': 'dromaeojs-e10s', 04:54:04 INFO - 'system_bits': '32', 04:54:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:54:04 INFO - 'title': 't-yosemite-r7-0129', 04:54:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:54:04 INFO - 'use_talos_json': True, 04:54:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:54:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:54:04 INFO - 'work_dir': 'build'} 04:54:04 INFO - ##### 04:54:04 INFO - ##### Running clobber step. 04:54:04 INFO - ##### 04:54:04 INFO - Running pre-action listener: _resource_record_pre_action 04:54:04 INFO - Running main action method: clobber 04:54:04 INFO - rmtree: /builds/slave/test/build 04:54:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:54:06 INFO - Running post-action listener: _resource_record_post_action 04:54:06 INFO - ##### 04:54:06 INFO - ##### Running read-buildbot-config step. 04:54:06 INFO - ##### 04:54:06 INFO - Running pre-action listener: _resource_record_pre_action 04:54:06 INFO - Running main action method: read_buildbot_config 04:54:06 INFO - Using buildbot properties: 04:54:06 INFO - { 04:54:06 INFO - "project": "", 04:54:06 INFO - "product": "firefox", 04:54:06 INFO - "script_repo_revision": "production", 04:54:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:54:06 INFO - "repository": "", 04:54:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:54:06 INFO - "buildid": "20160216032350", 04:54:06 INFO - "pgo_build": "False", 04:54:06 INFO - "basedir": "/builds/slave/test", 04:54:06 INFO - "buildnumber": 436, 04:54:06 INFO - "slavename": "t-yosemite-r7-0129", 04:54:06 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:54:06 INFO - "platform": "yosemite_r7", 04:54:06 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:54:06 INFO - "branch": "fx-team", 04:54:06 INFO - "repo_path": "integration/fx-team", 04:54:06 INFO - "revision": "6ea654cad929c9bedd8a4161a182b6189fbeae6a", 04:54:06 INFO - "stage_platform": "macosx64", 04:54:06 INFO - "builduid": "c39347d2ca2647419ac9f2b37dad19be", 04:54:06 INFO - "slavebuilddir": "test" 04:54:06 INFO - } 04:54:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:54:06 INFO - Running post-action listener: _resource_record_post_action 04:54:06 INFO - ##### 04:54:06 INFO - ##### Running download-and-extract step. 04:54:06 INFO - ##### 04:54:06 INFO - Running pre-action listener: _resource_record_pre_action 04:54:06 INFO - Running main action method: download_and_extract 04:54:06 INFO - mkdir: /builds/slave/test/build/tests 04: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')]} 04:54:06 INFO - https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:54:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/test_packages.json 04:54:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/test_packages.json 04:54:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:54:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:54:13 INFO - Downloaded 1277 bytes. 04:54:13 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:54:13 INFO - Using the following test package requirements: 04:54:13 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:54:13 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:54:13 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:54:13 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:54:13 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:54:13 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:54:13 INFO - u'jsshell-mac.zip'], 04:54:13 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:54:13 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:54:13 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:54:13 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:54:13 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:54:13 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:54:13 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:54:13 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:54:13 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:54:13 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:54:13 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:54:13 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:54:13 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:54:13 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')]} 04:54:13 INFO - https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:54:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:54:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:54:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:54:15 INFO - Downloaded 17803043 bytes. 04:54:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:54:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:54:18 INFO - Return code: 0 04:54:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:54:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:18 INFO - https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:54:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:54:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:54:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:54:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:54:21 INFO - Downloaded 17803043 bytes. 04:54:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:54:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:54:24 INFO - Return code: 0 04:54: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')]} 04:54:24 INFO - https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:54:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:54:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:54:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:54:25 INFO - Downloaded 10707071 bytes. 04:54:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:54:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:54:25 INFO - Return code: 0 04:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:25 INFO - https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:54:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:54:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:54:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:54:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:54:29 INFO - Downloaded 111149436 bytes. 04:54:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:54:29 INFO - mkdir: /builds/slave/test/properties 04:54:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:54:29 INFO - Writing to file /builds/slave/test/properties/build_url 04:54:29 INFO - Contents: 04:54:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:54:31 INFO - Running post-action listener: _resource_record_post_action 04:54:31 INFO - Running post-action listener: set_extra_try_arguments 04:54:31 INFO - ##### 04:54:31 INFO - ##### Running populate-webroot step. 04:54:31 INFO - ##### 04:54:31 INFO - Running pre-action listener: _resource_record_pre_action 04:54:31 INFO - Running main action method: populate_webroot 04:54:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:31 INFO - '--tppagecycles', 04:54:31 INFO - '7'], 04:54:31 INFO - 'tests': ['tsvgm']}}, 04:54:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:54:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:54:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:54:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:54:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:54:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:31 INFO - 'talos_options': ['--e10s'], 04:54:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:31 INFO - 'tests': ['damp', 'tps']}, 04:54:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:31 INFO - 'talos_options': ['--e10s'], 04:54:31 INFO - 'tests': ['damp', 'tps']}, 04:54:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:54:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:31 INFO - 'other': {'tests': ['a11yr', 04:54:31 INFO - 'ts_paint', 04:54:31 INFO - 'tpaint', 04:54:31 INFO - 'sessionrestore', 04:54:31 INFO - 'sessionrestore_no_auto_restore']}, 04:54:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:54:31 INFO - 'tests': ['a11yr', 04:54:31 INFO - 'ts_paint', 04:54:31 INFO - 'tpaint', 04:54:31 INFO - 'sessionrestore', 04:54:31 INFO - 'sessionrestore_no_auto_restore']}, 04:54:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:54:31 INFO - 'tests': ['a11yr', 04:54:31 INFO - 'ts_paint', 04:54:31 INFO - 'tpaint', 04:54:31 INFO - 'sessionrestore', 04:54:31 INFO - 'sessionrestore_no_auto_restore']}, 04:54:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:54:31 INFO - 'tests': ['a11yr', 04:54:31 INFO - 'ts_paint', 04:54:31 INFO - 'tpaint', 04:54:31 INFO - 'sessionrestore', 04:54:31 INFO - 'sessionrestore_no_auto_restore']}, 04:54:31 INFO - 'other_l64': {'tests': ['a11yr', 04:54:31 INFO - 'ts_paint', 04:54:31 INFO - 'tpaint', 04:54:31 INFO - 'sessionrestore', 04:54:31 INFO - 'sessionrestore_no_auto_restore']}, 04:54:31 INFO - 'other_nol64': {'tests': ['a11yr', 04:54:31 INFO - 'ts_paint', 04:54:31 INFO - 'tpaint', 04:54:31 INFO - 'sessionrestore', 04:54:31 INFO - 'sessionrestore_no_auto_restore']}, 04:54:31 INFO - 'svgr': {'tests': ['tsvgx', 04:54:31 INFO - 'tsvgr_opacity', 04:54:31 INFO - 'tart', 04:54:31 INFO - 'tscrollx', 04:54:31 INFO - 'cart']}, 04:54:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:54:31 INFO - 'tests': ['tsvgx', 04:54:31 INFO - 'tsvgr_opacity', 04:54:31 INFO - 'tart', 04:54:31 INFO - 'tscrollx', 04:54:31 INFO - 'cart']}, 04:54:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:31 INFO - 'tests': ['tp5o']}, 04:54:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:31 INFO - 'talos_options': ['--e10s'], 04:54:31 INFO - 'tests': ['tp5o']}, 04:54:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:31 INFO - 'talos_options': ['--xperf_path', 04:54:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:31 INFO - 'tests': ['tp5n']}, 04:54:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:31 INFO - 'talos_options': ['--e10s', 04:54:31 INFO - '--xperf_path', 04:54:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:31 INFO - 'tests': ['tp5n']}}, 04:54:31 INFO - 'talos.zip': {'path': '', 04:54:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:31 INFO - Running post-action listener: _resource_record_post_action 04:54:31 INFO - ##### 04:54:31 INFO - ##### Running create-virtualenv step. 04:54:31 INFO - ##### 04:54:31 INFO - Running pre-action listener: _resource_record_pre_action 04:54:31 INFO - Running main action method: create_virtualenv 04:54:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:54:31 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 04:54:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:54:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:31 INFO - Using real prefix '/tools/python27' 04:54:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:54:31 INFO - Installing distribute.............................................................................................................................................................................................done. 04:54:34 INFO - Installing pip.................done. 04:54:34 INFO - Return code: 0 04:54:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:34 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 0x10bacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd532c948e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b972d30>, '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 0x10b796db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b969b20>, '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.PUW5zjGhQW/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.U5r2da56Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:54:34 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 04:54:34 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 04:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PUW5zjGhQW/Render', 04:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:34 INFO - 'HOME': '/Users/cltbld', 04:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:34 INFO - 'LOGNAME': 'cltbld', 04:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:34 INFO - 'MOZ_NO_REMOTE': '1', 04:54:34 INFO - 'NO_EM_RESTART': '1', 04:54:34 INFO - 'PAGER': '/bin/cat', 04:54:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:34 INFO - 'PWD': '/builds/slave/test', 04:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:34 INFO - 'SHELL': '/bin/bash', 04:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5r2da56Ni/Listeners', 04:54:34 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:34 INFO - 'USER': 'cltbld', 04:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:34 INFO - 'XPC_FLAGS': '0x0', 04:54:34 INFO - 'XPC_SERVICE_NAME': '0', 04:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:35 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 04:54:35 INFO - Cleaning up... 04:54:35 INFO - Return code: 0 04:54:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:54:35 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')]} 04:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:35 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')]} 04:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:35 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 0x10bacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd532c948e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b972d30>, '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 0x10b796db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b969b20>, '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.PUW5zjGhQW/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.U5r2da56Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:54:35 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 04:54:35 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 04:54:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PUW5zjGhQW/Render', 04:54:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:35 INFO - 'HOME': '/Users/cltbld', 04:54:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:35 INFO - 'LOGNAME': 'cltbld', 04:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:35 INFO - 'MOZ_NO_REMOTE': '1', 04:54:35 INFO - 'NO_EM_RESTART': '1', 04:54:35 INFO - 'PAGER': '/bin/cat', 04:54:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:35 INFO - 'PWD': '/builds/slave/test', 04:54:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:35 INFO - 'SHELL': '/bin/bash', 04:54:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5r2da56Ni/Listeners', 04:54:35 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:54:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:35 INFO - 'USER': 'cltbld', 04:54:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:35 INFO - 'XPC_FLAGS': '0x0', 04:54:35 INFO - 'XPC_SERVICE_NAME': '0', 04:54:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:35 INFO - Downloading/unpacking psutil>=0.7.1 04:54:35 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 04:54:35 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 04:54:35 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 04:54:35 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 04:54:35 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 04:54:35 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 04:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:54:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:38 INFO - Installing collected packages: psutil 04:54:38 INFO - Running setup.py install for psutil 04:54:38 INFO - building 'psutil._psutil_osx' extension 04:54:38 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 04:54:38 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 04:54:38 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 04:54:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:54:39 INFO - building 'psutil._psutil_posix' extension 04:54:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:54:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:54:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:54:39 INFO - ^ 04:54:39 INFO - 1 warning generated. 04:54:39 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 04:54:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:39 INFO - Successfully installed psutil 04:54:39 INFO - Cleaning up... 04:54:39 INFO - Return code: 0 04:54:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:39 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 0x10bacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd532c948e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b972d30>, '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 0x10b796db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b969b20>, '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.PUW5zjGhQW/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.U5r2da56Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:54:39 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 04:54:39 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 04:54:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PUW5zjGhQW/Render', 04:54:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:39 INFO - 'HOME': '/Users/cltbld', 04:54:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:39 INFO - 'LOGNAME': 'cltbld', 04:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:39 INFO - 'MOZ_NO_REMOTE': '1', 04:54:39 INFO - 'NO_EM_RESTART': '1', 04:54:39 INFO - 'PAGER': '/bin/cat', 04:54:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:39 INFO - 'PWD': '/builds/slave/test', 04:54:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:39 INFO - 'SHELL': '/bin/bash', 04:54:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5r2da56Ni/Listeners', 04:54:39 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:54:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:39 INFO - 'USER': 'cltbld', 04:54:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:39 INFO - 'XPC_FLAGS': '0x0', 04:54:39 INFO - 'XPC_SERVICE_NAME': '0', 04:54:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:54:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:54:42 INFO - Installing collected packages: mozsystemmonitor 04:54:42 INFO - Running setup.py install for mozsystemmonitor 04:54:42 INFO - Successfully installed mozsystemmonitor 04:54:42 INFO - Cleaning up... 04:54:43 INFO - Return code: 0 04:54:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd532c948e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b972d30>, '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 0x10b796db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b969b20>, '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.PUW5zjGhQW/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.U5r2da56Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:54:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PUW5zjGhQW/Render', 04:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:43 INFO - 'HOME': '/Users/cltbld', 04:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:43 INFO - 'LOGNAME': 'cltbld', 04:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:43 INFO - 'MOZ_NO_REMOTE': '1', 04:54:43 INFO - 'NO_EM_RESTART': '1', 04:54:43 INFO - 'PAGER': '/bin/cat', 04:54:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:43 INFO - 'PWD': '/builds/slave/test', 04:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:43 INFO - 'SHELL': '/bin/bash', 04:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5r2da56Ni/Listeners', 04:54:43 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:43 INFO - 'USER': 'cltbld', 04:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:43 INFO - 'XPC_FLAGS': '0x0', 04:54:43 INFO - 'XPC_SERVICE_NAME': '0', 04:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:43 INFO - Downloading/unpacking blobuploader==1.2.4 04:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:54:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:54:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:46 INFO - Downloading docopt-0.6.1.tar.gz 04:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:54:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:54:46 INFO - Running setup.py install for blobuploader 04:54:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:54:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:54:47 INFO - Running setup.py install for requests 04:54:47 INFO - Running setup.py install for docopt 04:54:47 INFO - Successfully installed blobuploader requests docopt 04:54:47 INFO - Cleaning up... 04:54:47 INFO - Return code: 0 04:54:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd532c948e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b972d30>, '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 0x10b796db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b969b20>, '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.PUW5zjGhQW/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.U5r2da56Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:54:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PUW5zjGhQW/Render', 04:54:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:47 INFO - 'HOME': '/Users/cltbld', 04:54:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:47 INFO - 'LOGNAME': 'cltbld', 04:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:47 INFO - 'MOZ_NO_REMOTE': '1', 04:54:47 INFO - 'NO_EM_RESTART': '1', 04:54:47 INFO - 'PAGER': '/bin/cat', 04:54:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:47 INFO - 'PWD': '/builds/slave/test', 04:54:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:47 INFO - 'SHELL': '/bin/bash', 04:54:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5r2da56Ni/Listeners', 04:54:47 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:54:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:47 INFO - 'USER': 'cltbld', 04:54:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:47 INFO - 'XPC_FLAGS': '0x0', 04:54:47 INFO - 'XPC_SERVICE_NAME': '0', 04:54:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:48 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-B6Fhhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:48 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-ZcXxUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:48 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-vM_c0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:48 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-LbzTaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:48 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-6uC6fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:48 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Y60O1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:48 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-7iEwTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:48 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-3cG6mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:48 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-HOqOQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:48 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-SjVbXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:49 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-qU53ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:49 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-AKjDKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:49 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-vtQ8yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:49 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-3jKesK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:49 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-d3gP9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:49 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-b3tkkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:49 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-6vST5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:54:49 INFO - Running setup.py install for manifestparser 04:54:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:54:49 INFO - Running setup.py install for mozcrash 04:54:50 INFO - Running setup.py install for mozdebug 04:54:50 INFO - Running setup.py install for mozdevice 04:54:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Running setup.py install for mozfile 04:54:50 INFO - Running setup.py install for mozhttpd 04:54:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Running setup.py install for mozinfo 04:54:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Running setup.py install for mozInstall 04:54:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Running setup.py install for mozleak 04:54:51 INFO - Running setup.py install for mozlog 04:54:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:54:51 INFO - Running setup.py install for moznetwork 04:54:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:54:51 INFO - Running setup.py install for mozprocess 04:54:51 INFO - Running setup.py install for mozprofile 04:54:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:54:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:54:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:54:51 INFO - Running setup.py install for mozrunner 04:54:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:54:51 INFO - Running setup.py install for mozscreenshot 04:54:52 INFO - Running setup.py install for moztest 04:54:52 INFO - Running setup.py install for mozversion 04:54:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:54:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:54:52 INFO - Cleaning up... 04:54:52 INFO - Return code: 0 04:54:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd532c948e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b972d30>, '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 0x10b796db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b969b20>, '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.PUW5zjGhQW/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.U5r2da56Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:54:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:54:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PUW5zjGhQW/Render', 04:54:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:52 INFO - 'HOME': '/Users/cltbld', 04:54:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:52 INFO - 'LOGNAME': 'cltbld', 04:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:52 INFO - 'MOZ_NO_REMOTE': '1', 04:54:52 INFO - 'NO_EM_RESTART': '1', 04:54:52 INFO - 'PAGER': '/bin/cat', 04:54:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:52 INFO - 'PWD': '/builds/slave/test', 04:54:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:52 INFO - 'SHELL': '/bin/bash', 04:54:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5r2da56Ni/Listeners', 04:54:52 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:54:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:52 INFO - 'USER': 'cltbld', 04:54:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:52 INFO - 'XPC_FLAGS': '0x0', 04:54:52 INFO - 'XPC_SERVICE_NAME': '0', 04:54:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:52 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-KIrVw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:52 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-v4VE_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:52 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-U4CKkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:52 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-jzfxno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:53 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Q3su3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:53 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-2LZEtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:53 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Or0Jj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:53 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-QOvzUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:53 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-NloV0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:53 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-l2NGF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:53 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-3WTaHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:53 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-VJy3BY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:53 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-TmOo8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:54 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-hy2Gcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:54 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-kj03HN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:54 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-EDUuI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:54 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-hwPMP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:56 INFO - Downloading blessings-1.6.tar.gz 04:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:54:56 INFO - Installing collected packages: blessings 04:54:56 INFO - Running setup.py install for blessings 04:54:57 INFO - Successfully installed blessings 04:54:57 INFO - Cleaning up... 04:54:57 INFO - Return code: 0 04:54:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:54:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:57 INFO - Reading from file tmpfile_stdout 04:54:57 INFO - Current package versions: 04:54:57 INFO - blessings == 1.6 04:54:57 INFO - blobuploader == 1.2.4 04:54:57 INFO - docopt == 0.6.1 04:54:57 INFO - manifestparser == 1.1 04:54:57 INFO - mozInstall == 1.12 04:54:57 INFO - mozcrash == 0.16 04:54:57 INFO - mozdebug == 0.1 04:54:57 INFO - mozdevice == 0.48 04:54:57 INFO - mozfile == 1.2 04:54:57 INFO - mozhttpd == 0.7 04:54:57 INFO - mozinfo == 0.9 04:54:57 INFO - mozleak == 0.1 04:54:57 INFO - mozlog == 3.1 04:54:57 INFO - moznetwork == 0.27 04:54:57 INFO - mozprocess == 0.22 04:54:57 INFO - mozprofile == 0.28 04:54:57 INFO - mozrunner == 6.11 04:54:57 INFO - mozscreenshot == 0.1 04:54:57 INFO - mozsystemmonitor == 0.0 04:54:57 INFO - moztest == 0.7 04:54:57 INFO - mozversion == 1.4 04:54:57 INFO - psutil == 3.1.1 04:54:57 INFO - requests == 1.2.3 04:54:57 INFO - wsgiref == 0.1.2 04:54:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd532c948e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b972d30>, '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 0x10b796db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b969b20>, '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.PUW5zjGhQW/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.U5r2da56Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:54:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PUW5zjGhQW/Render', 04:54:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:57 INFO - 'HOME': '/Users/cltbld', 04:54:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:57 INFO - 'LOGNAME': 'cltbld', 04:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:57 INFO - 'MOZ_NO_REMOTE': '1', 04:54:57 INFO - 'NO_EM_RESTART': '1', 04:54:57 INFO - 'PAGER': '/bin/cat', 04:54:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:57 INFO - 'PWD': '/builds/slave/test', 04:54:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:57 INFO - 'SHELL': '/bin/bash', 04:54:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5r2da56Ni/Listeners', 04:54:57 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:54:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:57 INFO - 'USER': 'cltbld', 04:54:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:57 INFO - 'XPC_FLAGS': '0x0', 04:54:57 INFO - 'XPC_SERVICE_NAME': '0', 04:54:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:54:57 INFO - Cleaning up... 04:54:57 INFO - Return code: 0 04:54:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd532c948e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b972d30>, '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 0x10b796db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b969b20>, '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.PUW5zjGhQW/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.U5r2da56Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:54:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PUW5zjGhQW/Render', 04:54:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:57 INFO - 'HOME': '/Users/cltbld', 04:54:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:57 INFO - 'LOGNAME': 'cltbld', 04:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:57 INFO - 'MOZ_NO_REMOTE': '1', 04:54:57 INFO - 'NO_EM_RESTART': '1', 04:54:57 INFO - 'PAGER': '/bin/cat', 04:54:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:57 INFO - 'PWD': '/builds/slave/test', 04:54:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:57 INFO - 'SHELL': '/bin/bash', 04:54:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5r2da56Ni/Listeners', 04:54:57 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:54:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:57 INFO - 'USER': 'cltbld', 04:54:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:57 INFO - 'XPC_FLAGS': '0x0', 04:54:57 INFO - 'XPC_SERVICE_NAME': '0', 04:54:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:57 INFO - Downloading/unpacking jsonschema 04:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:55:00 INFO - Downloading/unpacking functools32 (from jsonschema) 04:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:00 INFO - Downloading functools32-3.2.3-2.tar.gz 04:55:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:55:00 INFO - warning: no files found matching '*.txt' 04:55:00 INFO - no previously-included directories found matching 'build' 04:55:00 INFO - no previously-included directories found matching 'dist' 04:55:00 INFO - no previously-included directories found matching '.git*' 04:55:00 INFO - Installing collected packages: jsonschema, functools32 04:55:00 INFO - Running setup.py install for functools32 04:55:00 INFO - warning: no files found matching '*.txt' 04:55:00 INFO - no previously-included directories found matching 'build' 04:55:00 INFO - no previously-included directories found matching 'dist' 04:55:00 INFO - no previously-included directories found matching '.git*' 04:55:00 INFO - Successfully installed jsonschema functools32 04:55:00 INFO - Cleaning up... 04:55:00 INFO - Return code: 0 04:55:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bad54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd532c948e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b972d30>, '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 0x10b796db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b969b20>, '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.PUW5zjGhQW/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.U5r2da56Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:55:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:55:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PUW5zjGhQW/Render', 04:55:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:00 INFO - 'HOME': '/Users/cltbld', 04:55:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:00 INFO - 'LOGNAME': 'cltbld', 04:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:00 INFO - 'MOZ_NO_REMOTE': '1', 04:55:00 INFO - 'NO_EM_RESTART': '1', 04:55:00 INFO - 'PAGER': '/bin/cat', 04:55:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:00 INFO - 'PWD': '/builds/slave/test', 04:55:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:00 INFO - 'SHELL': '/bin/bash', 04:55:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5r2da56Ni/Listeners', 04:55:00 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:55:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:00 INFO - 'USER': 'cltbld', 04:55:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:00 INFO - 'XPC_FLAGS': '0x0', 04:55:00 INFO - 'XPC_SERVICE_NAME': '0', 04:55:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:01 INFO - Downloading/unpacking flake8 04:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:55:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:55:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:55:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:55:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:55:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:55:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:55:04 INFO - no previously-included directories found matching 'docs/_build' 04:55:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:55:04 INFO - Running setup.py install for pep8 04:55:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:55:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:55:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:55:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:55:04 INFO - no previously-included directories found matching 'docs/_build' 04:55:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:55:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:55:04 INFO - Cleaning up... 04:55:05 INFO - Return code: 0 04:55:05 INFO - Running post-action listener: _resource_record_post_action 04:55:05 INFO - Running post-action listener: _start_resource_monitoring 04:55:05 INFO - Starting resource monitoring. 04:55:05 INFO - ##### 04:55:05 INFO - ##### Running install step. 04:55:05 INFO - ##### 04:55:05 INFO - Running pre-action listener: _resource_record_pre_action 04:55:05 INFO - Running main action method: install 04:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:55:05 INFO - Reading from file tmpfile_stdout 04:55:05 INFO - Detecting whether we're running mozinstall >=1.0... 04:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:55:05 INFO - Reading from file tmpfile_stdout 04:55:05 INFO - Output received: 04:55:05 INFO - Usage: mozinstall [options] installer 04:55:05 INFO - Options: 04:55:05 INFO - -h, --help show this help message and exit 04:55:05 INFO - -d DEST, --destination=DEST 04:55:05 INFO - Directory to install application into. [default: 04:55:05 INFO - "/builds/slave/test"] 04:55:05 INFO - --app=APP Application being installed. [default: firefox] 04:55:05 INFO - mkdir: /builds/slave/test/build/application 04:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:55:38 INFO - Reading from file tmpfile_stdout 04:55:38 INFO - Output received: 04:55:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:55:38 INFO - Running post-action listener: _resource_record_post_action 04:55:38 INFO - ##### 04:55:38 INFO - ##### Running run-tests step. 04:55:38 INFO - ##### 04:55:38 INFO - Running pre-action listener: _resource_record_pre_action 04:55:38 INFO - Running main action method: run_tests 04:55:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:55:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:55:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:55:38 INFO - 2016-02-16 04:55:38.997 screenresolution[1652:7598] starting screenresolution argv=screenresolution get 04:55:38 INFO - 2016-02-16 04:55:38.999 screenresolution[1652:7598] Display 0: 1600x1200x32@60 04:55:39 INFO - 2016-02-16 04:55:39.005 screenresolution[1653:7600] starting screenresolution argv=screenresolution list 04:55:39 INFO - Available Modes on Display 0 04:55:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:55:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:55:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:55:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:55:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:55:39 INFO - Intel Iris: 04:55:39 INFO - Chipset Model: Intel Iris 04:55:39 INFO - Type: GPU 04:55:39 INFO - Bus: Built-In 04:55:39 INFO - VRAM (Dynamic, Max): 1536 MB 04:55:39 INFO - Vendor: Intel (0x8086) 04:55:39 INFO - Device ID: 0x0a2e 04:55:39 INFO - Revision ID: 0x0009 04:55:39 INFO - Displays: 04:55:39 INFO - Display: 04:55:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:55:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:55:39 INFO - Display Serial Number: 1600x1200 60 04:55:39 INFO - Main Display: Yes 04:55:39 INFO - Mirror: Off 04:55:39 INFO - Online: Yes 04:55:39 INFO - Rotation: Supported 04:55:39 INFO - Return code: 0 04:55:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:55:39 INFO - Python 2.7.3 04:55:39 INFO - Return code: 0 04:55:39 INFO - grabbing minidump binary from tooltool 04:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b972d30>, '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 0x10b796db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b969b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:55:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:55:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:55:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:55:39 INFO - Return code: 0 04:55:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:55:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:55:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:55:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:55:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:55:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:55:40 INFO - Return code: 0 04:55:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--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 04:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0129 --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 04:55:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PUW5zjGhQW/Render', 04:55:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:40 INFO - 'HOME': '/Users/cltbld', 04:55:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:40 INFO - 'LOGNAME': 'cltbld', 04:55:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:55:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:40 INFO - 'MOZ_NO_REMOTE': '1', 04:55:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:55:40 INFO - 'NO_EM_RESTART': '1', 04:55:40 INFO - 'PAGER': '/bin/cat', 04:55:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:40 INFO - 'PWD': '/builds/slave/test', 04:55:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:55:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:40 INFO - 'SHELL': '/bin/bash', 04:55:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5r2da56Ni/Listeners', 04:55:40 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:55:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:40 INFO - 'USER': 'cltbld', 04:55:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:40 INFO - 'XPC_FLAGS': '0x0', 04:55:40 INFO - 'XPC_SERVICE_NAME': '0', 04:55:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--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 04:55:40 INFO - mozversion application_buildid: 20160216032350 04:55:40 INFO - mozversion application_changeset: 6ea654cad929c9bedd8a4161a182b6189fbeae6a 04:55:40 INFO - mozversion application_display_name: Nightly 04:55:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:55:40 INFO - mozversion application_name: Firefox 04:55:40 INFO - mozversion application_remotingname: firefox 04:55:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:55:40 INFO - mozversion application_vendor: Mozilla 04:55:40 INFO - mozversion application_version: 47.0a1 04:55:40 INFO - mozversion platform_buildid: 20160216032350 04:55:40 INFO - mozversion platform_changeset: 6ea654cad929c9bedd8a4161a182b6189fbeae6a 04:55:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:55:40 INFO - mozversion platform_version: 47.0a1 04:55:40 INFO - using testdate: 1455627340 04:55:40 INFO - actual date: 1455627340 04:55:41 INFO - starting webserver on 'localhost:49275' 04:55:41 INFO - SUITE-START | Running 2 tests 04:55:41 INFO - TEST-START | dromaeo_css 04:55:41 INFO - operating with platform_type : mac_ 04:55:41 INFO - Initialising browser for dromaeo_css test... 04:55:41 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmp5Ju602/profile http://localhost:49275/getInfo.html) 04:55:44 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 04:55:44 INFO - PROCESS | 1671 | colorDepth:24 04:55:44 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 04:55:44 INFO - PROCESS | 1671 | __metrics 04:55:44 INFO - TEST-INFO | 1671: exit 0 04:55:44 INFO - Browser initialized. 04:55:44 INFO - Running cycle 1/1 for dromaeo_css test... 04:55:44 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmp5Ju602/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:56 INFO - PROCESS | 1675 | RSS: Main: 257945600 04:55:56 INFO - PROCESS | 1675 | 04:56:46 INFO - PROCESS | 1675 | 1455627406474 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] 04:58:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 04:58:58 INFO - PROCESS | 1675 | RSS: Main: 270548992 04:58:58 INFO - PROCESS | 1675 | 05:02:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 05:02:01 INFO - PROCESS | 1675 | RSS: Main: 282550272 05:02:01 INFO - PROCESS | 1675 | 05:05:02 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 05:05:03 INFO - PROCESS | 1675 | RSS: Main: 284962816 05:05:03 INFO - PROCESS | 1675 | 05:08:05 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 05:08:05 INFO - PROCESS | 1675 | RSS: Main: 285851648 05:08:05 INFO - PROCESS | 1675 | 05:11:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 05:11:09 INFO - PROCESS | 1675 | RSS: Main: 287227904 05:11:09 INFO - PROCESS | 1675 | 05:14:11 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 05:14:11 INFO - PROCESS | 1675 | RSS: Main: 290381824 05:14:11 INFO - PROCESS | 1675 | 05:14:11 INFO - PROCESS | 1675 | __start_tp_report 05:14:11 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 05:14:11 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 05:14:11 INFO - PROCESS | 1675 | |i|pagename|runs| 05:14:11 INFO - PROCESS | 1675 | |0;dojo.html;3437.9140521486966;3480.7041401480856;3494.4234201356776;3529.5940966788826;3547.8048707321104;5523.309586301712;5546.306711661043;5567.860803479915;5577.665340079598;5599.216109744634;4608.53914608539;5442.727863606814;5543.52880005199;5594.272744543214;5695.8576035599135;5042.243663450494;5049.9747501262445;5079.1365467870555;5159.045576568347;5227.2159176123505;5120.8975820483565;5139.897202055957;5196;5202.479752024805;5231.764570594332;3947.388154836005;4905.215165573509;4967.205247160437;5066.392032956069;5087.821926232601;5074.873128171788;5106;5113.360829896263;5128.948710512922;5183.429822719498;4153.460050193486;4514.661400394951;4926.3595732554895;5060.089183946925;5092.363454568179;5482.780688772445;5501.587380946445;5508.366537848118;5531.502164805187;5550.611457197998;5996.640201587918;6015.969920150415;6061.999770037938;6065.059915713072;6076.453119219292;5950.107483877409;5983.1025346197985;6131.724072416708;6133.907991380132;6157.938420615781;5608.5793565482345;5642.830715078554;5646.124850648156;5651.208830763697;5681.091025435951;6224.719887605069;6230.470410015199;6254.843628909222;6256.7810126645345;6284.151639528605;5353.732313384316;5498.780048798083;5675.489205971482;5892.322382925932;5927.206587783822;6091.360407157184;6104.3590423005835;6134.539909506716;6145;6197.938020619736;5853.94146058534;5967.224260846062;6043.516518678495;6061.575689701766;6091.847703807441;6096.556923351615;6100.678570187591;6123.537002805139;6133.334663918993;6151.200343955257;4788.880277993008;4805.255185446262;4811.206150985118;4826.975865120652;4831.613470922318;4263.70154089217;4288.849890253826;4293.2272191005295;4351.8694439166875;4355.564443555619;5569.19246709233;5570.832875013756;5576.86057848557;5601.915971260434;5650.802221922213;5984.640921544721;6172.506199504029;6181.505479561624;6206.813795586139;6209.130721698965;5561.165825126263;5581.748821303051;5601.355844077902;5604.187392828017;5650.660960342392;5237.135872581058;5263.578913686896;5296.947030529645;5314.521693047567;5334.973325133427;4740.786664600101;6136.120845438929;6143.047827586731;6211.472024877846;6286.8428289292215;6123.770712314271;6140.631562106288;6153.015517517176;6155.784547540815;6178.104174894705;6211.59624624416;6252.874942501034;6253.124562561154;6270.968645156745;6288.119663247057;5808.273965754281;5977.103434484862;6002.33974262822;6063.696815159313;6102.79223100439;6166.630002199882;6182.598131121463;6185.567010309415;6212.254529456313;6218.315985241529;5950.910736338872;5962.4633782959745;5997.880042399215;6002.459778619946;6023.159866860711;5717.885642287214;5888.4700376966275;5927.851803704942;5933.881322373442;6018.7291571878495;5695.971520142539;5759.96320662268;5837.620554663933;5840.8247752567495;5884.470397664059;5738.311402631711;5884.705764711662;5944.821655350346;5962.642241465526;5980.8803823924145;5822.534197264124;5823.679697616672;5838.241028666246;5850.356460789225;5889.204957330706 05:14:11 INFO - PROCESS | 1675 | |1;ext.html;453.383398577934;460.92164332063544;561.6940613074602;569.4903061759725;599.2030599302927;36994.63005369945;37346.81326593363;37382.43926341107;37570.62429375706;37580.43629345558;39059.60940390595;39662.40506392407;39701.60298397015;39725;39827.40258896119;7551.773446796605;8770.517621530813;9450.810983780337;9649;9690.127888490035;9449.763755906122;9576.23390128788;9593.136617704406;9610.279229057815;9658.806823863519;9556.99651536589;9635.855462168072;9645.373050751714;9656;9677.129058384744;9549;9598.328117031811;9619.855702164474;9630.75923101921;9635.13283804461;9396.577154028017;9496.620135194584;9527.09492598202;9533.380330278509;9553.474558899257;38026.85919422422;38199.809000955094;38358.424623630664;38360;38365;2793.748562629353;3177.22158071274;3273.459879119966;3407.863685452579;3496.1958749487762;27165.45669086607;27426.588601171;27600.447991040266;27604.585931211048;28113.718862811314;2701.6622922134734;2795.203367040384;2814.394905095394;2846.5303224967856;2950.837703926283;359695;360132.79734405427;360915.1954240212;361202.9999999974;362189;50638;55276;62139;64199.679001605626;64738.67630661817;58384.70807645935;62199.6890015547;62276.688616556625;62370.376296236456;62899;15907.761383579256;16011.679766404606;16012.959157654715;16046.358145674043;16219.513414597344;12103;12265.957393621464;12346.81479777804;12384;12506.937465312798;19593.608127837364;19756;19913.701294480594;19931.501712457306;20024.799752002295;6754.797356079325;8170.714025009096;8224.38317126218;8284.668613255402;8304.460210086325;792.5007245435454;999.4203362049993;1087.0814162033068;1095.3427943233996;1097.720081379243;29311;29582.260443489085;29635.85182074119;30114.54828177579;30115.397692046474;1071.839224116373;1081.6538707613645;1117.435694974033;1202.963911082669;1252.3988485526997;13754.724905501835;14922.850771492145;15088.698226035418;15312.923435382752;15529.61133562849;530355;532343;536485;537532;538082;47749;47809;58278.7086064567;58444.70777646085;58727;1338.3575883575938;1409.6123566019426;1433.433793651502;1451.7894905238893;1452.7167202395642;29505.409891802472;29976.550351744307;30060.699393006664;30273.08892589007;31583;53870.65323366947;54140.10509632144;54546.45453545414;54724.63188420162;54921;440078.59921400377;443279;444143;444777.7761111174;445154;30904.0728778137;32295.51556726698;32993.68025278962;33258.00225993224;33278.667213328525;32975;40685;40722.77831665055;40898.29798272058;41551.58448415598;34275.31449371049;34963.65036349706;34977.825110874284;35016.299674005866;35395.46906796349;34485.827570861984;34628.78799242115;34805.825970869984;34823.65176348305;34839;35033;36071.458928116626;36270.4559431614;36322.09194770152;36589.634103659686;30592;30637.693623063486;32139.517907230944;32358.514622280214;32387.19032024218;19311.710324344866;24460;24582.385440364134;24876.502469950137;24982.875085624455 05:14:11 INFO - PROCESS | 1675 | |2;jquery.html;326.52001557710156;358.4336747938258;363.7235700867342;363.83445532282803;364.58437381385215;15290.770638440432;18715.783474074193;19162.520936976583;19226.711599326005;19951.401457956268;9740.561674724637;11587.884121158786;11807.822882656745;11950.521979120826;19766.901165494153;5184.740762961856;5204.9329887373;5333.493318134771;5528.170774383854;5826.533877289807;5129.179331306992;5781.53747700183;5837.8832423351505;5908.763649454038;5916.792912248072;3877.495925529677;5308.92036619451;5326.360836699582;5396.946030539703;5703.914441283384;5880.941190588125;5899.32157801854;5907.527397808165;5934.851628709317;5949.286085669725;5310.309659744247;5460.836174914759;5487.204355368489;5489.149181876815;5498.697571633558;13297.734045319039;14791.70416591662;15500.379984800595;23646.29061128169;23691.644625330635;1987.175322241268;2126.117661170628;2204.4268490192503;2249.0216755711153;2490.7260201378017;9857.852132218022;9874.308798384116;13974.882009439221;14785.408583656641;14819.333130009176;1700.957476063096;1738.9217485213196;1760.146329030419;1786.20513871326;1809.4209852846964;89056;98706.50646746792;99278.0072199276;100480.49759751154;101327;11058.612948546763;11335.093192544577;11337.036351910016;11356.48895799691;11358.432078396047;13385.263810490516;13414.12808167466;13429.328533573282;13466.663333416547;13470.797938030937;7209.963950180216;8454.535000575028;8488.278496327757;8553.700620478254;8633.827323453495;8726.607302671395;8747.256483198998;8760.342974276955;8795.780105497413;8817.382783205114;4384.12317536494;4415.66882483815;4473.709208901411;4478.440194975628;4518.164139634113;1854.9536261593298;1878.342580096955;1908.2843933524928;1911.7705875295053;1924.1341396371408;409.3961406924762;416.54388444653057;417.2177167810295;441.61579425899674;460.6821293307607;11219.775604487864;12072.215306005257;12081.275123492618;12104;19920.3027894023;900.9819803603891;942.7595963029521;951.70497145885;962.7304354780673;977.9755506112405;8386.496810191407;8719.302455803521;10227.28409011377;10672.893271067345;11481.88518114825;723346;730730;740002;747363;753076;112772.43613782043;115774;117742;119197;119483;1182.5506307603227;1188.9286642801287;1222.3032871263295;1228.6989687526614;1264.2667252993242;15520.5343839685;17734.93590384581;17874.731879021565;18103.637927241645;19167.712484313026;35670.57317707263;46692;49899.750501248716;51504;52581;61567.69216153891;68476.6576167116;70495.64752176206;71013.28986710067;71123;7611.467197296136;7787.961060194662;7818.100918394457;7823.804404889924;7909.604519774103;7057;10195.796084078425;10426.27016108865;10761.085307748928;11370.090392768394;8056.436049476481;10179.796404071729;10417.374957502574;10561.683149505527;10590.735231619272;8653.567321633767;10143.137833283958;10363.844542332023;10498.233039669321;10642.255042146975;9857.408555486694;10230.28388012832;10659.307145035858;10882.347059176474;10887.727806804893;6300.873982520416;7598.696052158073;7699;7780.92219077802;7810.492317999312;9851.45816980073;10109.292349535755;10661.733456663334;10843.783124337311;10843.861394553458 05:14:11 INFO - PROCESS | 1675 | |3;mootools.html;1558.9688206235876;1562.429713154699;1814.1654838774164;1906.599614081042;1924.0860591219182;8053.516788992664;8747.606357713903;8870.379073464852;8946.060663630322;9101.590428430713;8797.164269394398;8813;8905.376623636348;8915.554222288893;8926.687565935177;2484.503099380122;2489.079040754919;2508.8620125893067;2516.924492265235;2517.773400393964;2106.083853523722;2202.119152339061;2405.0740464920955;2530.253575195313;2536.5180615683053;2203.6694495825673;2447.79193768529;2499.250224932522;2502.311864237331;2508.046942161985;2469.7283298837115;2475.925722228336;2495.1765917247267;2495.251424572621;2513.6355228491857;2452.889619967106;2482.168473561359;2496.4757400945823;2501.7498250175017;2505.6116301973225;8957.149070838324;8998.415103018282;9016.053314402025;9020.77448063797;9031.142041506113;5459.945400545984;5543.445655434464;5646.40712725162;5655.462731040545;5656.858578535528;3648.6351364863567;3726.776393416377;3754.7371683982133;3769.5476542815036;3771.6228377162065;1051.2693677893867;1071.9249652524327;1074.0870260278778;1100.4222783038888;1100.4607742206342;12291;12432.937835310857;12444;12476.75046499065;12483.875161248363;4226.682998775104;4553.317002449659;4946.579540739005;5002.824901128443;5036.6726162799305;10248.333858299187;10360.689179324632;10383.169346452265;10389.532471038821;10415.218858585486;5450.182472629137;5487.506124448819;5553.028220061473;5590.720463976785;5605.299337582802;4979.053979743837;4999;5053.852112852023;5080.77136528857;5083.74581270935;3327.251368442081;3647.6899463545365;3826.3303921814127;4050.4531888194715;4095.7542547447247;1242.2546472116837;1345.6770375109902;1346.4681450826868;1349.2713934475469;1360.2586590308306;1093.3986307530827;1104.7072525780675;1133.3539882267028;1155.5320095361392;1239.7768401687601;7966.283034526805;8106.918930810734;8174.67301307941;8209.220124088202;8289.668413263402;1188.1742189178437;1193.3496244546743;1199.1066655341651;1208.945597448117;1217.3973882928008;5461.15352120422;6039.849003774941;6211.627302361872;6314.147590075281;6330.556861019684;10512.684619461428;10683.62607308756;10717.410542420086;10771.946140269249;10814.29707069038;10505.159587233004;10578.312409693346;10615.097716694014;10696.94651526753;10715.19636027301;8340.958295208606;8363.080061193265;8426.620802063922;8489.702860399857;8563.100874408223;7342.449316301406;7791.298783109547;8206.343492520704;8306.169383061888;8308.376871734523;9599.184069354184;9762.414255144715;9797.167240784613;9846;9948.502574871372;9732;10135.341202821794;10139.695809125738;10205.795884082128;10303.53634086453;7560.395168386406;7563.9621801890635;7668.539887606761;7690.1925297845155;7690.846183076195;8188.713395031145;8319.958400207961;8392.244697977212;8408.621612027597;8424.873626895724;6692.397684208445;7787.727429539939;7883.329916957123;7956.801079973047;8033.718819841278;7024.683889225099;7706.882502037285;7753.612319384121;7876.960615196887;7909.9209007909185;7338.302861228175;7920.485168464032;7924.762257132295;7971.800704982422;7991.760247192594;7024.227334993045;7118.8932166018585;7171.175314838861;7177.856442871218;7183.281671832775;7145.39264162552;7198.7840364789145;7267.491275610657;7276.527025743521;7320.96339518299 05:14:11 INFO - PROCESS | 1675 | |4;prototype.html;283.76022261189297;326.9771116021878;333.76136062715153;334.00466609503695;334.241272311852;5142.562882155016;5821.476067153955;6787.898181527281;6914.305995031212;6978.406835418996;6882.96558517208;6909.343612356818;6943.409810166129;6963.756268530602;6966.547174433671;5124.461931497195;5132.948670513303;5134.383873935133;5144.17693169093;5150.201718733583;4808.3989501312335;5109.616778741609;5127.743612819344;5153.613478989091;5167.612429067835;4213.431186789775;4710.7880145393365;4906.141425250585;4921.4094308682825;4924.827631032915;4901.191303434929;4906.165951788187;4926.088673595361;4927.802887884481;4929.309896614477;3573.3032058748554;3973.0861901762755;4054.695897807647;4153.646940010103;4182.64447521961;5182;5227.947720522822;6465.903011454832;6604.834879128012;6627.337266273383;4740.857774266778;4774.474807771142;5864.970675146639;5881.823545293648;5907.734151963172;7146.106736657918;7209.459290553229;7332.120145582564;7348.889766653451;7352.816179595499;3882.941755873664;4679.461861885893;4693.131770622445;4705;4710.434747830248;6861.730579842695;7223.313785190451;7669.6932122715025;7741.961290193569;7749.147593764681;4601.08120952892;4733.739644319527;4745.84064250772;4746.1931471649905;4752.3584316116885;4424.203643344164;4757.476677565465;4852.587530059914;4856.053069651454;4859.2954021666665;4805.399325084364;5754.712264386764;5818.44724751148;5821.068629019336;5824.15549745293;6811.557248778813;7331.853362932711;7353.117625884821;7367.557946523226;7395.260473952561;1642.7289497232823;1665.7334826427714;1684.7894013248344;1684.7978242610966;1691.9678995812544;1059.0309866472091;1063.5267306048888;1071.132382769959;1074.785042991405;1079.0881704959297;5888.676122813201;6884.311568843075;6912.688928998207;6912.723491060301;6937.930620693728;7646.694132234759;7810.609469526501;7812.023497062867;7859.331956783623;7885.526868387915;6696.430803381767;6871.347222013901;6888.621125838127;6903.619276144691;6946.6034218194645;3919.3729003359326;3976.224636195914;4054.412110243998;4093.1813637272667;4110.630043296058;7897.526148431112;7919.920800791919;7925.326347260432;7931.881021784678;7942.404319676048;7867.9606601966625;7953.8409231816195;7964.1637628049375;7964.522128672298;7973.322267607318;6547;7308.817279568053;8002.5598592077995;8018.679252829938;8026.518408895485;7665.961670191613;7667.808304792202;7672.73145439907;7678.500897441649;7726.845463090819;7251.093613298338;7493.737719179802;7537.359324457482;7539.472236943361;7563;7956.920430795618;8009.959950200212;8034.317083047773;8037.075736290168;8050.919490805017;4728.668993170445;4793.448753393265;4796.592289655418;4797.920467894695;4806.807727690853;7405.5926924019695;7639.159692433939;7691.807704807425;7727.304542591194;7733.613319333898;7403.185649578434;7409.703611855465;7411.0736157980255;7413.073365829271;7425.925740742523;7369.152547457111;7390.260973902782;7392.778216653509;7432.033835601554;7435.256474352522;6160.44555989963;7014.929850701427;7204.819879503054;7296.452766042674;7297.1973082961895;7345.632718363953;7347.485676002629;7369.373603243785;7385.372243359375;7399.519031262951;7029.507934444539;7144.4998850082075;7221;7224.638768061681;7250.89123663156 05:14:11 INFO - PROCESS | 1675 | |5;yui.html;601.4166258729033;666.336994690283;704.9330313620204;717.6878058044749;725.1588157737026;14736.336864841081;15093.773593396094;15125;17110.31558737649;17353.219105140266;12997.545085921995;15765.975211611267;15784.526464206092;15823.99999999997;15849.84150158498;693.5076095971841;836.6109758962082;853.129807596253;863.3740538109882;864.1358641358642;798.2177466083212;849.7026040885671;851.429542206723;861.3195575495382;863.5552690364467;885.9069797671249;905.5110240470138;908.5411867007185;909.2135302962955;910.5856835139996;883.5670521444478;896.3546246702364;899.3884158772032;900.3247564326722;904.39405598249;671.5668393885965;677.2245778583494;678.0575000748963;679.2121139478231;679.4258851270669;14879.553613391616;14961.775573366409;15061.849381506154;15076.849231507655;15097.3206205721;12527.310997895112;12544.686382840411;12701.74596508074;12905.612831615066;13189.878860296887;9957.601695932153;10062.69811905644;10067.29528932975;10085.798284034352;10088.445135517544;3459.290845376717;3484.163800687842;3487.3548393547276;3493.807840568768;3505.404081306159;63403;82873.58563207145;83420.16579834184;83791;83910;9580.66467673628;9680.419174849532;9710.368826026286;9983.450910199863;10357.378557286587;20540.281090161774;20664;20758.273460428813;20792;20958.371248862557;7416.629168541552;7513.624318784039;7695;7854;7981.281684648409;4167.229062623424;4168.645665118499;4201.096764195651;4261.936070958938;4405.052913623586;3517.806520641338;3558.87543935961;3562.608113107608;3572.9285414291567;3588.174719814457;643.5784561112479;650.5381179362705;656.2813718977711;661.0480907493194;668.909697190873;532.7842223899327;538.9730513474389;610.9999900488668;621.6580880515698;636.9299377068519;8185.672573097128;8441.66233350659;8480.194381533744;8555.14448555152;8669.26311263537;501.9046381187563;517.0202466326291;584.421422791442;623.7536173211556;625.9812205633838;3821.7515861468914;3976.4631774710624;4076.184763047402;4085.7140000200293;4093.467849179647;86537.70193447103;88200.5589972046;92944.53527732319;93540;93598.53200733953;75336;76076.0980975469;76136.23863761402;76776;79841;70253.24366890869;70419.2958070423;70825.93761093587;72534.2746572538;72667.6366618174;8729.869051964353;8817.07420720815;8836.204741573289;8870.008496176617;8918.777030574287;48470.75764621155;48505.5149448501;50667.98664026625;50684.74657626688;50825.49174508208;61664.38335616586;68370.31629683639;71625;72322;72517.6374118147;10779.946100269448;10798.514066866852;10916.345019298868;11251.943740281245;11290.15323850698;11766.411679415824;11879.287242765462;12188.634340969786;12379.62594508577;12652.430640621378;9075.2286055686;11121.610743623934;11169.832452513056;11436.542538298374;12131.454084566392;9423.340366174576;11192.272502287326;11470.139739519736;11597.6520704379;12253;10261.384316940708;10820.45897705096;10880.455977201267;11137;11268.549258029914;7607.543547387175;8769.605367758339;8822.558872056243;8828.823423531621;9425;8829.955850220707;8879.28965682731;9016.684416045407;9107.726768196964;9487.66793162236 05:14:11 INFO - PROCESS | 1675 | __end_tp_report 05:14:11 INFO - PROCESS | 1675 | __start_cc_report 05:14:11 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,358 05:14:11 INFO - PROCESS | 1675 | __end_cc_report 05:14:11 INFO - PROCESS | 1675 | __startTimestamp1455628451596__endTimestamp 05:14:11 INFO - PROCESS | 1675 | 05:14:11 INFO - PROCESS | 1675 | ------- Summary: start ------- 05:14:11 INFO - PROCESS | 1675 | Number of tests: 6 05:14:11 INFO - PROCESS | 1675 | 05:14:11 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5591.94 Median:5759.96 stddev:640.08 (11.1%) stddev-sans-first:619.34 05:14:11 INFO - PROCESS | 1675 | Values: 3437.9 3480.7 3494.4 3529.6 3547.8 5523.3 5546.3 5567.9 5577.7 5599.2 4608.5 5442.7 5543.5 5594.3 5695.9 5042.2 5050.0 5079.1 5159.0 5227.2 5120.9 5139.9 5196.0 5202.5 5231.8 3947.4 4905.2 4967.2 5066.4 5087.8 5074.9 5106.0 5113.4 5128.9 5183.4 4153.5 4514.7 4926.4 5060.1 5092.4 5482.8 5501.6 5508.4 5531.5 5550.6 5996.6 6016.0 6062.0 6065.1 6076.5 5950.1 5983.1 6131.7 6133.9 6157.9 5608.6 5642.8 5646.1 5651.2 5681.1 6224.7 6230.5 6254.8 6256.8 6284.2 5353.7 5498.8 5675.5 5892.3 5927.2 6091.4 6104.4 6134.5 6145.0 6197.9 5853.9 5967.2 6043.5 6061.6 6091.8 6096.6 6100.7 6123.5 6133.3 6151.2 4788.9 4805.3 4811.2 4827.0 4831.6 4263.7 4288.8 4293.2 4351.9 4355.6 5569.2 5570.8 5576.9 5601.9 5650.8 5984.6 6172.5 6181.5 6206.8 6209.1 5561.2 5581.7 5601.4 5604.2 5650.7 5237.1 5263.6 5296.9 5314.5 5335.0 4740.8 6136.1 6143.0 6211.5 6286.8 6123.8 6140.6 6153.0 6155.8 6178.1 6211.6 6252.9 6253.1 6271.0 6288.1 5808.3 5977.1 6002.3 6063.7 6102.8 6166.6 6182.6 6185.6 6212.3 6218.3 5950.9 5962.5 5997.9 6002.5 6023.2 5717.9 5888.5 5927.9 5933.9 6018.7 5696.0 5760.0 5837.6 5840.8 5884.5 5738.3 5884.7 5944.8 5962.6 5980.9 5822.5 5823.7 5838.2 5850.4 5889.2 05:14:11 INFO - PROCESS | 1675 | 05:14:11 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:59256.59 Median:199229.73 stddev:120104.19 (60.3%) stddev-sans-first:120359.96 05:14:11 INFO - PROCESS | 1675 | Values: 453.4 460.9 561.7 569.5 599.2 36994.6 37346.8 37382.4 37570.6 37580.4 39059.6 39662.4 39701.6 39725.0 39827.4 7551.8 8770.5 9450.8 9649.0 9690.1 9449.8 9576.2 9593.1 9610.3 9658.8 9557.0 9635.9 9645.4 9656.0 9677.1 9549.0 9598.3 9619.9 9630.8 9635.1 9396.6 9496.6 9527.1 9533.4 9553.5 38026.9 38199.8 38358.4 38360.0 38365.0 2793.7 3177.2 3273.5 3407.9 3496.2 27165.5 27426.6 27600.4 27604.6 28113.7 2701.7 2795.2 2814.4 2846.5 2950.8 359695.0 360132.8 360915.2 361203.0 362189.0 50638.0 55276.0 62139.0 64199.7 64738.7 58384.7 62199.7 62276.7 62370.4 62899.0 15907.8 16011.7 16013.0 16046.4 16219.5 12103.0 12266.0 12346.8 12384.0 12506.9 19593.6 19756.0 19913.7 19931.5 20024.8 6754.8 8170.7 8224.4 8284.7 8304.5 792.5 999.4 1087.1 1095.3 1097.7 29311.0 29582.3 29635.9 30114.5 30115.4 1071.8 1081.7 1117.4 1203.0 1252.4 13754.7 14922.9 15088.7 15312.9 15529.6 530355.0 532343.0 536485.0 537532.0 538082.0 47749.0 47809.0 58278.7 58444.7 58727.0 1338.4 1409.6 1433.4 1451.8 1452.7 29505.4 29976.6 30060.7 30273.1 31583.0 53870.7 54140.1 54546.5 54724.6 54921.0 440078.6 443279.0 444143.0 444777.8 445154.0 30904.1 32295.5 32993.7 33258.0 33278.7 32975.0 40685.0 40722.8 40898.3 41551.6 34275.3 34963.7 34977.8 35016.3 35395.5 34485.8 34628.8 34805.8 34823.7 34839.0 35033.0 36071.5 36270.5 36322.1 36589.6 30592.0 30637.7 32139.5 32358.5 32387.2 19311.7 24460.0 24582.4 24876.5 24982.9 05:14:11 INFO - PROCESS | 1675 | 05:14:11 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:36712.22 Median:363.78 stddev:121760.42 (33471.0%) stddev-sans-first:122071.34 05:14:11 INFO - PROCESS | 1675 | Values: 326.5 358.4 363.7 363.8 364.6 15290.8 18715.8 19162.5 19226.7 19951.4 9740.6 11587.9 11807.8 11950.5 19766.9 5184.7 5204.9 5333.5 5528.2 5826.5 5129.2 5781.5 5837.9 5908.8 5916.8 3877.5 5308.9 5326.4 5396.9 5703.9 5880.9 5899.3 5907.5 5934.9 5949.3 5310.3 5460.8 5487.2 5489.1 5498.7 13297.7 14791.7 15500.4 23646.3 23691.6 1987.2 2126.1 2204.4 2249.0 2490.7 9857.9 9874.3 13974.9 14785.4 14819.3 1701.0 1738.9 1760.1 1786.2 1809.4 89056.0 98706.5 99278.0 100480.5 101327.0 11058.6 11335.1 11337.0 11356.5 11358.4 13385.3 13414.1 13429.3 13466.7 13470.8 7210.0 8454.5 8488.3 8553.7 8633.8 8726.6 8747.3 8760.3 8795.8 8817.4 4384.1 4415.7 4473.7 4478.4 4518.2 1855.0 1878.3 1908.3 1911.8 1924.1 409.4 416.5 417.2 441.6 460.7 11219.8 12072.2 12081.3 12104.0 19920.3 901.0 942.8 951.7 962.7 978.0 8386.5 8719.3 10227.3 10672.9 11481.9 723346.0 730730.0 740002.0 747363.0 753076.0 112772.4 115774.0 117742.0 119197.0 119483.0 1182.6 1188.9 1222.3 1228.7 1264.3 15520.5 17734.9 17874.7 18103.6 19167.7 35670.6 46692.0 49899.8 51504.0 52581.0 61567.7 68476.7 70495.6 71013.3 71123.0 7611.5 7788.0 7818.1 7823.8 7909.6 7057.0 10195.8 10426.3 10761.1 11370.1 8056.4 10179.8 10417.4 10561.7 10590.7 8653.6 10143.1 10363.8 10498.2 10642.3 9857.4 10230.3 10659.3 10882.3 10887.7 6300.9 7598.7 7699.0 7780.9 7810.5 9851.5 10109.3 10661.7 10843.8 10843.9 05:14:11 INFO - PROCESS | 1675 | 05:14:11 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:6166.85 Median:5045.26 stddev:3261.29 (64.6%) stddev-sans-first:3252.04 05:14:11 INFO - PROCESS | 1675 | Values: 1559.0 1562.4 1814.2 1906.6 1924.1 8053.5 8747.6 8870.4 8946.1 9101.6 8797.2 8813.0 8905.4 8915.6 8926.7 2484.5 2489.1 2508.9 2516.9 2517.8 2106.1 2202.1 2405.1 2530.3 2536.5 2203.7 2447.8 2499.3 2502.3 2508.0 2469.7 2475.9 2495.2 2495.3 2513.6 2452.9 2482.2 2496.5 2501.7 2505.6 8957.1 8998.4 9016.1 9020.8 9031.1 5459.9 5543.4 5646.4 5655.5 5656.9 3648.6 3726.8 3754.7 3769.5 3771.6 1051.3 1071.9 1074.1 1100.4 1100.5 12291.0 12432.9 12444.0 12476.8 12483.9 4226.7 4553.3 4946.6 5002.8 5036.7 10248.3 10360.7 10383.2 10389.5 10415.2 5450.2 5487.5 5553.0 5590.7 5605.3 4979.1 4999.0 5053.9 5080.8 5083.7 3327.3 3647.7 3826.3 4050.5 4095.8 1242.3 1345.7 1346.5 1349.3 1360.3 1093.4 1104.7 1133.4 1155.5 1239.8 7966.3 8106.9 8174.7 8209.2 8289.7 1188.2 1193.3 1199.1 1208.9 1217.4 5461.2 6039.8 6211.6 6314.1 6330.6 10512.7 10683.6 10717.4 10771.9 10814.3 10505.2 10578.3 10615.1 10696.9 10715.2 8341.0 8363.1 8426.6 8489.7 8563.1 7342.4 7791.3 8206.3 8306.2 8308.4 9599.2 9762.4 9797.2 9846.0 9948.5 9732.0 10135.3 10139.7 10205.8 10303.5 7560.4 7564.0 7668.5 7690.2 7690.8 8188.7 8320.0 8392.2 8408.6 8424.9 6692.4 7787.7 7883.3 7956.8 8033.7 7024.7 7706.9 7753.6 7877.0 7909.9 7338.3 7920.5 7924.8 7971.8 7991.8 7024.2 7118.9 7171.2 7177.9 7183.3 7145.4 7198.8 7267.5 7276.5 7321.0 05:14:11 INFO - PROCESS | 1675 | 05:14:11 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:5945.17 Median:6883.64 stddev:1964.44 (28.5%) stddev-sans-first:1923.45 05:14:11 INFO - PROCESS | 1675 | Values: 283.8 327.0 333.8 334.0 334.2 5142.6 5821.5 6787.9 6914.3 6978.4 6883.0 6909.3 6943.4 6963.8 6966.5 5124.5 5132.9 5134.4 5144.2 5150.2 4808.4 5109.6 5127.7 5153.6 5167.6 4213.4 4710.8 4906.1 4921.4 4924.8 4901.2 4906.2 4926.1 4927.8 4929.3 3573.3 3973.1 4054.7 4153.6 4182.6 5182.0 5227.9 6465.9 6604.8 6627.3 4740.9 4774.5 5865.0 5881.8 5907.7 7146.1 7209.5 7332.1 7348.9 7352.8 3882.9 4679.5 4693.1 4705.0 4710.4 6861.7 7223.3 7669.7 7742.0 7749.1 4601.1 4733.7 4745.8 4746.2 4752.4 4424.2 4757.5 4852.6 4856.1 4859.3 4805.4 5754.7 5818.4 5821.1 5824.2 6811.6 7331.9 7353.1 7367.6 7395.3 1642.7 1665.7 1684.8 1684.8 1692.0 1059.0 1063.5 1071.1 1074.8 1079.1 5888.7 6884.3 6912.7 6912.7 6937.9 7646.7 7810.6 7812.0 7859.3 7885.5 6696.4 6871.3 6888.6 6903.6 6946.6 3919.4 3976.2 4054.4 4093.2 4110.6 7897.5 7919.9 7925.3 7931.9 7942.4 7868.0 7953.8 7964.2 7964.5 7973.3 6547.0 7308.8 8002.6 8018.7 8026.5 7666.0 7667.8 7672.7 7678.5 7726.8 7251.1 7493.7 7537.4 7539.5 7563.0 7956.9 8010.0 8034.3 8037.1 8050.9 4728.7 4793.4 4796.6 4797.9 4806.8 7405.6 7639.2 7691.8 7727.3 7733.6 7403.2 7409.7 7411.1 7413.1 7425.9 7369.2 7390.3 7392.8 7432.0 7435.3 6160.4 7014.9 7204.8 7296.5 7297.2 7345.6 7347.5 7369.4 7385.4 7399.5 7029.5 7144.5 7221.0 7224.6 7250.9 05:14:11 INFO - PROCESS | 1675 | 05:14:11 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:18284.43 Median:640.25 stddev:25621.23 (4001.7%) stddev-sans-first:25658.70 05:14:11 INFO - PROCESS | 1675 | Values: 601.4 666.3 704.9 717.7 725.2 14736.3 15093.8 15125.0 17110.3 17353.2 12997.5 15766.0 15784.5 15824.0 15849.8 693.5 836.6 853.1 863.4 864.1 798.2 849.7 851.4 861.3 863.6 885.9 905.5 908.5 909.2 910.6 883.6 896.4 899.4 900.3 904.4 671.6 677.2 678.1 679.2 679.4 14879.6 14961.8 15061.8 15076.8 15097.3 12527.3 12544.7 12701.7 12905.6 13189.9 9957.6 10062.7 10067.3 10085.8 10088.4 3459.3 3484.2 3487.4 3493.8 3505.4 63403.0 82873.6 83420.2 83791.0 83910.0 9580.7 9680.4 9710.4 9983.5 10357.4 20540.3 20664.0 20758.3 20792.0 20958.4 7416.6 7513.6 7695.0 7854.0 7981.3 4167.2 4168.6 4201.1 4261.9 4405.1 3517.8 3558.9 3562.6 3572.9 3588.2 643.6 650.5 656.3 661.0 668.9 532.8 539.0 611.0 621.7 636.9 8185.7 8441.7 8480.2 8555.1 8669.3 501.9 517.0 584.4 623.8 626.0 3821.8 3976.5 4076.2 4085.7 4093.5 86537.7 88200.6 92944.5 93540.0 93598.5 75336.0 76076.1 76136.2 76776.0 79841.0 70253.2 70419.3 70825.9 72534.3 72667.6 8729.9 8817.1 8836.2 8870.0 8918.8 48470.8 48505.5 50668.0 50684.7 50825.5 61664.4 68370.3 71625.0 72322.0 72517.6 10779.9 10798.5 10916.3 11251.9 11290.2 11766.4 11879.3 12188.6 12379.6 12652.4 9075.2 11121.6 11169.8 11436.5 12131.5 9423.3 11192.3 11470.1 11597.7 12253.0 10261.4 10820.5 10880.5 11137.0 11268.5 7607.5 8769.6 8822.6 8828.8 9425.0 8830.0 8879.3 9016.7 9107.7 9487.7 05:14:11 INFO - PROCESS | 1675 | -------- Summary: end -------- 05:14:11 INFO - PROCESS | 1675 | 05:14:12 INFO - TEST-INFO | 1675: exit 0 05:14:12 INFO - TEST-OK | dromaeo_css | took 1110898ms 05:14:12 INFO - TEST-START | kraken 05:14:12 INFO - operating with platform_type : mac_ 05:14:12 INFO - Initialising browser for kraken test... 05:14:12 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpeJydYO/profile http://localhost:49275/getInfo.html) 05:14:14 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 05:14:14 INFO - PROCESS | 1687 | colorDepth:24 05:14:14 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 05:14:14 INFO - PROCESS | 1687 | __metrics 05:14:15 INFO - TEST-INFO | 1687: exit 0 05:14:15 INFO - Browser initialized. 05:14:15 INFO - Running cycle 1/1 for kraken test... 05:14:15 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpeJydYO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:27 INFO - PROCESS | 1690 | RSS: Main: 257765376 05:14:27 INFO - PROCESS | 1690 | 05:14:30 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 05:14:30 INFO - PROCESS | 1690 | RSS: Main: 268255232 05:14:30 INFO - PROCESS | 1690 | 05:14:33 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 05:14:34 INFO - PROCESS | 1690 | RSS: Main: 277098496 05:14:34 INFO - PROCESS | 1690 | 05:14:37 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 05:14:37 INFO - PROCESS | 1690 | RSS: Main: 281731072 05:14:37 INFO - PROCESS | 1690 | 05:14:39 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 05:14:40 INFO - PROCESS | 1690 | RSS: Main: 282927104 05:14:40 INFO - PROCESS | 1690 | 05:14:42 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:14:43 INFO - PROCESS | 1690 | RSS: Main: 282951680 05:14:43 INFO - PROCESS | 1690 | 05:14:45 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 05:14:46 INFO - PROCESS | 1690 | RSS: Main: 284479488 05:14:46 INFO - PROCESS | 1690 | 05:14:49 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:49 INFO - PROCESS | 1690 | RSS: Main: 283844608 05:14:49 INFO - PROCESS | 1690 | 05:14:52 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 05:14:53 INFO - PROCESS | 1690 | RSS: Main: 284442624 05:14:53 INFO - PROCESS | 1690 | 05:14:54 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:14:55 INFO - PROCESS | 1690 | RSS: Main: 282832896 05:14:55 INFO - PROCESS | 1690 | 05:14:57 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:58 INFO - PROCESS | 1690 | RSS: Main: 283533312 05:14:58 INFO - PROCESS | 1690 | 05:15:00 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:15:00 INFO - PROCESS | 1690 | RSS: Main: 283746304 05:15:00 INFO - PROCESS | 1690 | 05:15:03 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:15:03 INFO - PROCESS | 1690 | RSS: Main: 283127808 05:15:03 INFO - PROCESS | 1690 | 05:15:06 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:15:07 INFO - PROCESS | 1690 | RSS: Main: 283963392 05:15:07 INFO - PROCESS | 1690 | 05:15:08 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 05:15:09 INFO - PROCESS | 1690 | RSS: Main: 284626944 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | __start_tp_report 05:15:09 INFO - PROCESS | 1690 | _x_x_mozilla_page_load 05:15:09 INFO - PROCESS | 1690 | _x_x_mozilla_page_load_details 05:15:09 INFO - PROCESS | 1690 | |i|pagename|runs| 05:15:09 INFO - PROCESS | 1690 | |0;ai-astar;115;111;115;115;115;129;115;114;117;114 05:15:09 INFO - PROCESS | 1690 | |1;audio-beat-detection;154;121;135;147;121;147;168;151;158;120 05:15:09 INFO - PROCESS | 1690 | |2;audio-dft;194;197;195;197;196;200;224;195;197;214 05:15:09 INFO - PROCESS | 1690 | |3;audio-fft;59;68;70;74;123;56;57;71;88;108 05:15:09 INFO - PROCESS | 1690 | |4;audio-oscillator;86;93;120;77;80;81;117;82;84;112 05:15:09 INFO - PROCESS | 1690 | |5;imaging-gaussian-blur;86;92;85;92;85;92;86;96;110;94 05:15:09 INFO - PROCESS | 1690 | |6;imaging-darkroom;95;95;94;94;95;95;95;96;96;95 05:15:09 INFO - PROCESS | 1690 | |7;imaging-desaturate;146;151;139;80;81;133;108;120;80;136 05:15:09 INFO - PROCESS | 1690 | |8;json-parse-financial;58;58;55;57;56;57;55;61;53;55 05:15:09 INFO - PROCESS | 1690 | |9;json-stringify-tinderbox;56;99;64;60;71;100;83;66;66;65 05:15:09 INFO - PROCESS | 1690 | |10;stanford-crypto-aes;84;84;85;86;84;86;83;87;87;85 05:15:09 INFO - PROCESS | 1690 | |11;stanford-crypto-ccm;131;128;123;111;142;136;137;145;122;127 05:15:09 INFO - PROCESS | 1690 | |12;stanford-crypto-pbkdf2;128;140;143;141;141;142;152;177;115;177 05:15:09 INFO - PROCESS | 1690 | |13;stanford-crypto-sha256-iterative;74;68;66;81;95;75;69;66;66;73 05:15:09 INFO - PROCESS | 1690 | __end_tp_report 05:15:09 INFO - PROCESS | 1690 | __start_cc_report 05:15:09 INFO - PROCESS | 1690 | _x_x_mozilla_cycle_collect,891 05:15:09 INFO - PROCESS | 1690 | __end_cc_report 05:15:09 INFO - PROCESS | 1690 | __startTimestamp1455628509000__endTimestamp 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | ------- Summary: start ------- 05:15:09 INFO - PROCESS | 1690 | Number of tests: 14 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#0] ai-astar Cycles:10 Average:116.00 Median:115.00 stddev:4.81 (4.2%) stddev-sans-first:5.09 05:15:09 INFO - PROCESS | 1690 | Values: 115.0 111.0 115.0 115.0 115.0 129.0 115.0 114.0 117.0 114.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:149.00 stddev:17.07 (11.5%) stddev-sans-first:17.56 05:15:09 INFO - PROCESS | 1690 | Values: 154.0 121.0 135.0 147.0 121.0 147.0 168.0 151.0 158.0 120.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#2] audio-dft Cycles:10 Average:200.90 Median:197.00 stddev:9.96 (5.1%) stddev-sans-first:10.25 05:15:09 INFO - PROCESS | 1690 | Values: 194.0 197.0 195.0 197.0 196.0 200.0 224.0 195.0 197.0 214.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#3] audio-fft Cycles:10 Average:77.40 Median:69.00 stddev:22.45 (32.5%) stddev-sans-first:22.80 05:15:09 INFO - PROCESS | 1690 | Values: 59.0 68.0 70.0 74.0 123.0 56.0 57.0 71.0 88.0 108.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:81.50 stddev:16.62 (20.4%) stddev-sans-first:17.42 05:15:09 INFO - PROCESS | 1690 | Values: 86.0 93.0 120.0 77.0 80.0 81.0 117.0 82.0 84.0 112.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#5] imaging-gaussian-blur Cycles:10 Average:91.80 Median:92.00 stddev:7.55 (8.2%) stddev-sans-first:7.72 05:15:09 INFO - PROCESS | 1690 | Values: 86.0 92.0 85.0 92.0 85.0 92.0 86.0 96.0 110.0 94.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:15:09 INFO - PROCESS | 1690 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 96.0 96.0 95.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#7] imaging-desaturate Cycles:10 Average:117.40 Median:148.50 stddev:28.32 (19.1%) stddev-sans-first:28.09 05:15:09 INFO - PROCESS | 1690 | Values: 146.0 151.0 139.0 80.0 81.0 133.0 108.0 120.0 80.0 136.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:2.22 (3.9%) stddev-sans-first:2.29 05:15:09 INFO - PROCESS | 1690 | Values: 58.0 58.0 55.0 57.0 56.0 57.0 55.0 61.0 53.0 55.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:66.00 stddev:15.67 (23.7%) stddev-sans-first:15.37 05:15:09 INFO - PROCESS | 1690 | Values: 56.0 99.0 64.0 60.0 71.0 100.0 83.0 66.0 66.0 65.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.50 stddev:1.37 (1.6%) stddev-sans-first:1.39 05:15:09 INFO - PROCESS | 1690 | Values: 84.0 84.0 85.0 86.0 84.0 86.0 83.0 87.0 87.0 85.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:133.50 stddev:10.23 (7.7%) stddev-sans-first:10.84 05:15:09 INFO - PROCESS | 1690 | Values: 131.0 128.0 123.0 111.0 142.0 136.0 137.0 145.0 122.0 127.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.60 Median:142.50 stddev:19.30 (13.5%) stddev-sans-first:19.39 05:15:09 INFO - PROCESS | 1690 | Values: 128.0 140.0 143.0 141.0 141.0 142.0 152.0 177.0 115.0 177.0 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - PROCESS | 1690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:73.50 stddev:9.07 (12.3%) stddev-sans-first:9.61 05:15:09 INFO - PROCESS | 1690 | Values: 74.0 68.0 66.0 81.0 95.0 75.0 69.0 66.0 66.0 73.0 05:15:09 INFO - PROCESS | 1690 | -------- Summary: end -------- 05:15:09 INFO - PROCESS | 1690 | 05:15:09 INFO - TEST-INFO | 1690: exit 0 05:15:09 INFO - TEST-OK | kraken | took 57672ms 05:15:09 INFO - SUITE-END | took 1168s 05:15:10 INFO - Completed test suite (00:19:28) 05:15:10 INFO - Working with test: dromaeo_css 05:15:10 INFO - Generating results file: dromaeo_css 05:15:10 INFO - Working with test: kraken 05:15:10 INFO - Generating results file: kraken 05:15:10 INFO - javascript benchmark 05:15:10 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:10 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 05:15:10 INFO - process_Request line: dromaeo_css 7436.67 graph.html#tests=[[72,64,61]] 05:15:10 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:10 INFO - process_Request line: kraken 1497.60 graph.html#tests=[[232,64,61]] 05:15:10 INFO - RETURN: dromaeo_css: 7436.67 05:15:10 INFO - RETURN: kraken: 1497.60 05:15:10 INFO - javascript benchmark 05:15:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3437.9140521486966, 3480.7041401480856, 3494.4234201356776, 3529.5940966788826, 3547.8048707321104, 5523.309586301712, 5546.306711661043, 5567.860803479915, 5577.665340079598, 5599.216109744634, 4608.53914608539, 5442.727863606814, 5543.52880005199, 5594.272744543214, 5695.8576035599135, 5042.243663450494, 5049.9747501262445, 5079.1365467870555, 5159.045576568347, 5227.2159176123505, 5120.8975820483565, 5139.897202055957, 5196.0, 5202.479752024805, 5231.764570594332, 3947.388154836005, 4905.215165573509, 4967.205247160437, 5066.392032956069, 5087.821926232601, 5074.873128171788, 5106.0, 5113.360829896263, 5128.948710512922, 5183.429822719498, 4153.460050193486, 4514.661400394951, 4926.3595732554895, 5060.089183946925, 5092.363454568179, 5482.780688772445, 5501.587380946445, 5508.366537848118, 5531.502164805187, 5550.611457197998, 5996.640201587918, 6015.969920150415, 6061.999770037938, 6065.059915713072, 6076.453119219292, 5950.107483877409, 5983.1025346197985, 6131.724072416708, 6133.907991380132, 6157.938420615781, 5608.5793565482345, 5642.830715078554, 5646.124850648156, 5651.208830763697, 5681.091025435951, 6224.719887605069, 6230.470410015199, 6254.843628909222, 6256.7810126645345, 6284.151639528605, 5353.732313384316, 5498.780048798083, 5675.489205971482, 5892.322382925932, 5927.206587783822, 6091.360407157184, 6104.3590423005835, 6134.539909506716, 6145.0, 6197.938020619736, 5853.94146058534, 5967.224260846062, 6043.516518678495, 6061.575689701766, 6091.847703807441, 6096.556923351615, 6100.678570187591, 6123.537002805139, 6133.334663918993, 6151.200343955257, 4788.880277993008, 4805.255185446262, 4811.206150985118, 4826.975865120652, 4831.613470922318, 4263.70154089217, 4288.849890253826, 4293.2272191005295, 4351.8694439166875, 4355.564443555619, 5569.19246709233, 5570.832875013756, 5576.86057848557, 5601.915971260434, 5650.802221922213, 5984.640921544721, 6172.506199504029, 6181.505479561624, 6206.813795586139, 6209.130721698965, 5561.165825126263, 5581.748821303051, 5601.355844077902, 5604.187392828017, 5650.660960342392, 5237.135872581058, 5263.578913686896, 5296.947030529645, 5314.521693047567, 5334.973325133427, 4740.786664600101, 6136.120845438929, 6143.047827586731, 6211.472024877846, 6286.8428289292215, 6123.770712314271, 6140.631562106288, 6153.015517517176, 6155.784547540815, 6178.104174894705, 6211.59624624416, 6252.874942501034, 6253.124562561154, 6270.968645156745, 6288.119663247057, 5808.273965754281, 5977.103434484862, 6002.33974262822, 6063.696815159313, 6102.79223100439, 6166.630002199882, 6182.598131121463, 6185.567010309415, 6212.254529456313, 6218.315985241529, 5950.910736338872, 5962.4633782959745, 5997.880042399215, 6002.459778619946, 6023.159866860711, 5717.885642287214, 5888.4700376966275, 5927.851803704942, 5933.881322373442, 6018.7291571878495, 5695.971520142539, 5759.96320662268, 5837.620554663933, 5840.8247752567495, 5884.470397664059, 5738.311402631711, 5884.705764711662, 5944.821655350346, 5962.642241465526, 5980.8803823924145, 5822.534197264124, 5823.679697616672, 5838.241028666246, 5850.356460789225, 5889.204957330706], "unit": "score", "name": "dojo.html", "value": 5553.12849286786}, {"lowerIsBetter": false, "replicates": [453.383398577934, 460.92164332063544, 561.6940613074602, 569.4903061759725, 599.2030599302927, 36994.63005369945, 37346.81326593363, 37382.43926341107, 37570.62429375706, 37580.43629345558, 39059.60940390595, 39662.40506392407, 39701.60298397015, 39725.0, 39827.40258896119, 7551.773446796605, 8770.517621530813, 9450.810983780337, 9649.0, 9690.127888490035, 9449.763755906122, 9576.23390128788, 9593.136617704406, 9610.279229057815, 9658.806823863519, 9556.99651536589, 9635.855462168072, 9645.373050751714, 9656.0, 9677.129058384744, 9549.0, 9598.328117031811, 9619.855702164474, 9630.75923101921, 9635.13283804461, 9396.577154028017, 9496.620135194584, 9527.09492598202, 9533.380330278509, 9553.474558899257, 38026.85919422422, 38199.809000955094, 38358.424623630664, 38360.0, 38365.0, 2793.748562629353, 3177.22158071274, 3273.459879119966, 3407.863685452579, 3496.1958749487762, 27165.45669086607, 27426.588601171, 27600.447991040266, 27604.585931211048, 28113.718862811314, 2701.6622922134734, 2795.203367040384, 2814.394905095394, 2846.5303224967856, 2950.837703926283, 359695.0, 360132.79734405427, 360915.1954240212, 361202.9999999974, 362189.0, 50638.0, 55276.0, 62139.0, 64199.679001605626, 64738.67630661817, 58384.70807645935, 62199.6890015547, 62276.688616556625, 62370.376296236456, 62899.0, 15907.761383579256, 16011.679766404606, 16012.959157654715, 16046.358145674043, 16219.513414597344, 12103.0, 12265.957393621464, 12346.81479777804, 12384.0, 12506.937465312798, 19593.608127837364, 19756.0, 19913.701294480594, 19931.501712457306, 20024.799752002295, 6754.797356079325, 8170.714025009096, 8224.38317126218, 8284.668613255402, 8304.460210086325, 792.5007245435454, 999.4203362049993, 1087.0814162033068, 1095.3427943233996, 1097.720081379243, 29311.0, 29582.260443489085, 29635.85182074119, 30114.54828177579, 30115.397692046474, 1071.839224116373, 1081.6538707613645, 1117.435694974033, 1202.963911082669, 1252.3988485526997, 13754.724905501835, 14922.850771492145, 15088.698226035418, 15312.923435382752, 15529.61133562849, 530355.0, 532343.0, 536485.0, 537532.0, 538082.0, 47749.0, 47809.0, 58278.7086064567, 58444.70777646085, 58727.0, 1338.3575883575938, 1409.6123566019426, 1433.433793651502, 1451.7894905238893, 1452.7167202395642, 29505.409891802472, 29976.550351744307, 30060.699393006664, 30273.08892589007, 31583.0, 53870.65323366947, 54140.10509632144, 54546.45453545414, 54724.63188420162, 54921.0, 440078.59921400377, 443279.0, 444143.0, 444777.7761111174, 445154.0, 30904.0728778137, 32295.51556726698, 32993.68025278962, 33258.00225993224, 33278.667213328525, 32975.0, 40685.0, 40722.77831665055, 40898.29798272058, 41551.58448415598, 34275.31449371049, 34963.65036349706, 34977.825110874284, 35016.299674005866, 35395.46906796349, 34485.827570861984, 34628.78799242115, 34805.825970869984, 34823.65176348305, 34839.0, 35033.0, 36071.458928116626, 36270.4559431614, 36322.09194770152, 36589.634103659686, 30592.0, 30637.693623063486, 32139.517907230944, 32358.514622280214, 32387.19032024218, 19311.710324344866, 24460.0, 24582.385440364134, 24876.502469950137, 24982.875085624455], "unit": "score", "name": "ext.html", "value": 19184.48453695528}, {"lowerIsBetter": false, "replicates": [326.52001557710156, 358.4336747938258, 363.7235700867342, 363.83445532282803, 364.58437381385215, 15290.770638440432, 18715.783474074193, 19162.520936976583, 19226.711599326005, 19951.401457956268, 9740.561674724637, 11587.884121158786, 11807.822882656745, 11950.521979120826, 19766.901165494153, 5184.740762961856, 5204.9329887373, 5333.493318134771, 5528.170774383854, 5826.533877289807, 5129.179331306992, 5781.53747700183, 5837.8832423351505, 5908.763649454038, 5916.792912248072, 3877.495925529677, 5308.92036619451, 5326.360836699582, 5396.946030539703, 5703.914441283384, 5880.941190588125, 5899.32157801854, 5907.527397808165, 5934.851628709317, 5949.286085669725, 5310.309659744247, 5460.836174914759, 5487.204355368489, 5489.149181876815, 5498.697571633558, 13297.734045319039, 14791.70416591662, 15500.379984800595, 23646.29061128169, 23691.644625330635, 1987.175322241268, 2126.117661170628, 2204.4268490192503, 2249.0216755711153, 2490.7260201378017, 9857.852132218022, 9874.308798384116, 13974.882009439221, 14785.408583656641, 14819.333130009176, 1700.957476063096, 1738.9217485213196, 1760.146329030419, 1786.20513871326, 1809.4209852846964, 89056.0, 98706.50646746792, 99278.0072199276, 100480.49759751154, 101327.0, 11058.612948546763, 11335.093192544577, 11337.036351910016, 11356.48895799691, 11358.432078396047, 13385.263810490516, 13414.12808167466, 13429.328533573282, 13466.663333416547, 13470.797938030937, 7209.963950180216, 8454.535000575028, 8488.278496327757, 8553.700620478254, 8633.827323453495, 8726.607302671395, 8747.256483198998, 8760.342974276955, 8795.780105497413, 8817.382783205114, 4384.12317536494, 4415.66882483815, 4473.709208901411, 4478.440194975628, 4518.164139634113, 1854.9536261593298, 1878.342580096955, 1908.2843933524928, 1911.7705875295053, 1924.1341396371408, 409.3961406924762, 416.54388444653057, 417.2177167810295, 441.61579425899674, 460.6821293307607, 11219.775604487864, 12072.215306005257, 12081.275123492618, 12104.0, 19920.3027894023, 900.9819803603891, 942.7595963029521, 951.70497145885, 962.7304354780673, 977.9755506112405, 8386.496810191407, 8719.302455803521, 10227.28409011377, 10672.893271067345, 11481.88518114825, 723346.0, 730730.0, 740002.0, 747363.0, 753076.0, 112772.43613782043, 115774.0, 117742.0, 119197.0, 119483.0, 1182.5506307603227, 1188.9286642801287, 1222.3032871263295, 1228.6989687526614, 1264.2667252993242, 15520.5343839685, 17734.93590384581, 17874.731879021565, 18103.637927241645, 19167.712484313026, 35670.57317707263, 46692.0, 49899.750501248716, 51504.0, 52581.0, 61567.69216153891, 68476.6576167116, 70495.64752176206, 71013.28986710067, 71123.0, 7611.467197296136, 7787.961060194662, 7818.100918394457, 7823.804404889924, 7909.604519774103, 7057.0, 10195.796084078425, 10426.27016108865, 10761.085307748928, 11370.090392768394, 8056.436049476481, 10179.796404071729, 10417.374957502574, 10561.683149505527, 10590.735231619272, 8653.567321633767, 10143.137833283958, 10363.844542332023, 10498.233039669321, 10642.255042146975, 9857.408555486694, 10230.28388012832, 10659.307145035858, 10882.347059176474, 10887.727806804893, 6300.873982520416, 7598.696052158073, 7699.0, 7780.92219077802, 7810.492317999312, 9851.45816980073, 10109.292349535755, 10661.733456663334, 10843.783124337311, 10843.861394553458], "unit": "score", "name": "jquery.html", "value": 8726.035252248637}, {"lowerIsBetter": false, "replicates": [1558.9688206235876, 1562.429713154699, 1814.1654838774164, 1906.599614081042, 1924.0860591219182, 8053.516788992664, 8747.606357713903, 8870.379073464852, 8946.060663630322, 9101.590428430713, 8797.164269394398, 8813.0, 8905.376623636348, 8915.554222288893, 8926.687565935177, 2484.503099380122, 2489.079040754919, 2508.8620125893067, 2516.924492265235, 2517.773400393964, 2106.083853523722, 2202.119152339061, 2405.0740464920955, 2530.253575195313, 2536.5180615683053, 2203.6694495825673, 2447.79193768529, 2499.250224932522, 2502.311864237331, 2508.046942161985, 2469.7283298837115, 2475.925722228336, 2495.1765917247267, 2495.251424572621, 2513.6355228491857, 2452.889619967106, 2482.168473561359, 2496.4757400945823, 2501.7498250175017, 2505.6116301973225, 8957.149070838324, 8998.415103018282, 9016.053314402025, 9020.77448063797, 9031.142041506113, 5459.945400545984, 5543.445655434464, 5646.40712725162, 5655.462731040545, 5656.858578535528, 3648.6351364863567, 3726.776393416377, 3754.7371683982133, 3769.5476542815036, 3771.6228377162065, 1051.2693677893867, 1071.9249652524327, 1074.0870260278778, 1100.4222783038888, 1100.4607742206342, 12291.0, 12432.937835310857, 12444.0, 12476.75046499065, 12483.875161248363, 4226.682998775104, 4553.317002449659, 4946.579540739005, 5002.824901128443, 5036.6726162799305, 10248.333858299187, 10360.689179324632, 10383.169346452265, 10389.532471038821, 10415.218858585486, 5450.182472629137, 5487.506124448819, 5553.028220061473, 5590.720463976785, 5605.299337582802, 4979.053979743837, 4999.0, 5053.852112852023, 5080.77136528857, 5083.74581270935, 3327.251368442081, 3647.6899463545365, 3826.3303921814127, 4050.4531888194715, 4095.7542547447247, 1242.2546472116837, 1345.6770375109902, 1346.4681450826868, 1349.2713934475469, 1360.2586590308306, 1093.3986307530827, 1104.7072525780675, 1133.3539882267028, 1155.5320095361392, 1239.7768401687601, 7966.283034526805, 8106.918930810734, 8174.67301307941, 8209.220124088202, 8289.668413263402, 1188.1742189178437, 1193.3496244546743, 1199.1066655341651, 1208.945597448117, 1217.3973882928008, 5461.15352120422, 6039.849003774941, 6211.627302361872, 6314.147590075281, 6330.556861019684, 10512.684619461428, 10683.62607308756, 10717.410542420086, 10771.946140269249, 10814.29707069038, 10505.159587233004, 10578.312409693346, 10615.097716694014, 10696.94651526753, 10715.19636027301, 8340.958295208606, 8363.080061193265, 8426.620802063922, 8489.702860399857, 8563.100874408223, 7342.449316301406, 7791.298783109547, 8206.343492520704, 8306.169383061888, 8308.376871734523, 9599.184069354184, 9762.414255144715, 9797.167240784613, 9846.0, 9948.502574871372, 9732.0, 10135.341202821794, 10139.695809125738, 10205.795884082128, 10303.53634086453, 7560.395168386406, 7563.9621801890635, 7668.539887606761, 7690.1925297845155, 7690.846183076195, 8188.713395031145, 8319.958400207961, 8392.244697977212, 8408.621612027597, 8424.873626895724, 6692.397684208445, 7787.727429539939, 7883.329916957123, 7956.801079973047, 8033.718819841278, 7024.683889225099, 7706.882502037285, 7753.612319384121, 7876.960615196887, 7909.9209007909185, 7338.302861228175, 7920.485168464032, 7924.762257132295, 7971.800704982422, 7991.760247192594, 7024.227334993045, 7118.8932166018585, 7171.175314838861, 7177.856442871218, 7183.281671832775, 7145.39264162552, 7198.7840364789145, 7267.491275610657, 7276.527025743521, 7320.96339518299], "unit": "score", "name": "mootools.html", "value": 5017.634842525129}, {"lowerIsBetter": false, "replicates": [283.76022261189297, 326.9771116021878, 333.76136062715153, 334.00466609503695, 334.241272311852, 5142.562882155016, 5821.476067153955, 6787.898181527281, 6914.305995031212, 6978.406835418996, 6882.96558517208, 6909.343612356818, 6943.409810166129, 6963.756268530602, 6966.547174433671, 5124.461931497195, 5132.948670513303, 5134.383873935133, 5144.17693169093, 5150.201718733583, 4808.3989501312335, 5109.616778741609, 5127.743612819344, 5153.613478989091, 5167.612429067835, 4213.431186789775, 4710.7880145393365, 4906.141425250585, 4921.4094308682825, 4924.827631032915, 4901.191303434929, 4906.165951788187, 4926.088673595361, 4927.802887884481, 4929.309896614477, 3573.3032058748554, 3973.0861901762755, 4054.695897807647, 4153.646940010103, 4182.64447521961, 5182.0, 5227.947720522822, 6465.903011454832, 6604.834879128012, 6627.337266273383, 4740.857774266778, 4774.474807771142, 5864.970675146639, 5881.823545293648, 5907.734151963172, 7146.106736657918, 7209.459290553229, 7332.120145582564, 7348.889766653451, 7352.816179595499, 3882.941755873664, 4679.461861885893, 4693.131770622445, 4705.0, 4710.434747830248, 6861.730579842695, 7223.313785190451, 7669.6932122715025, 7741.961290193569, 7749.147593764681, 4601.08120952892, 4733.739644319527, 4745.84064250772, 4746.1931471649905, 4752.3584316116885, 4424.203643344164, 4757.476677565465, 4852.587530059914, 4856.053069651454, 4859.2954021666665, 4805.399325084364, 5754.712264386764, 5818.44724751148, 5821.068629019336, 5824.15549745293, 6811.557248778813, 7331.853362932711, 7353.117625884821, 7367.557946523226, 7395.260473952561, 1642.7289497232823, 1665.7334826427714, 1684.7894013248344, 1684.7978242610966, 1691.9678995812544, 1059.0309866472091, 1063.5267306048888, 1071.132382769959, 1074.785042991405, 1079.0881704959297, 5888.676122813201, 6884.311568843075, 6912.688928998207, 6912.723491060301, 6937.930620693728, 7646.694132234759, 7810.609469526501, 7812.023497062867, 7859.331956783623, 7885.526868387915, 6696.430803381767, 6871.347222013901, 6888.621125838127, 6903.619276144691, 6946.6034218194645, 3919.3729003359326, 3976.224636195914, 4054.412110243998, 4093.1813637272667, 4110.630043296058, 7897.526148431112, 7919.920800791919, 7925.326347260432, 7931.881021784678, 7942.404319676048, 7867.9606601966625, 7953.8409231816195, 7964.1637628049375, 7964.522128672298, 7973.322267607318, 6547.0, 7308.817279568053, 8002.5598592077995, 8018.679252829938, 8026.518408895485, 7665.961670191613, 7667.808304792202, 7672.73145439907, 7678.500897441649, 7726.845463090819, 7251.093613298338, 7493.737719179802, 7537.359324457482, 7539.472236943361, 7563.0, 7956.920430795618, 8009.959950200212, 8034.317083047773, 8037.075736290168, 8050.919490805017, 4728.668993170445, 4793.448753393265, 4796.592289655418, 4797.920467894695, 4806.807727690853, 7405.5926924019695, 7639.159692433939, 7691.807704807425, 7727.304542591194, 7733.613319333898, 7403.185649578434, 7409.703611855465, 7411.0736157980255, 7413.073365829271, 7425.925740742523, 7369.152547457111, 7390.260973902782, 7392.778216653509, 7432.033835601554, 7435.256474352522, 6160.44555989963, 7014.929850701427, 7204.819879503054, 7296.452766042674, 7297.1973082961895, 7345.632718363953, 7347.485676002629, 7369.373603243785, 7385.372243359375, 7399.519031262951, 7029.507934444539, 7144.4998850082075, 7221.0, 7224.638768061681, 7250.89123663156], "unit": "score", "name": "prototype.html", "value": 5284.0035882025895}, {"lowerIsBetter": false, "replicates": [601.4166258729033, 666.336994690283, 704.9330313620204, 717.6878058044749, 725.1588157737026, 14736.336864841081, 15093.773593396094, 15125.0, 17110.31558737649, 17353.219105140266, 12997.545085921995, 15765.975211611267, 15784.526464206092, 15823.99999999997, 15849.84150158498, 693.5076095971841, 836.6109758962082, 853.129807596253, 863.3740538109882, 864.1358641358642, 798.2177466083212, 849.7026040885671, 851.429542206723, 861.3195575495382, 863.5552690364467, 885.9069797671249, 905.5110240470138, 908.5411867007185, 909.2135302962955, 910.5856835139996, 883.5670521444478, 896.3546246702364, 899.3884158772032, 900.3247564326722, 904.39405598249, 671.5668393885965, 677.2245778583494, 678.0575000748963, 679.2121139478231, 679.4258851270669, 14879.553613391616, 14961.775573366409, 15061.849381506154, 15076.849231507655, 15097.3206205721, 12527.310997895112, 12544.686382840411, 12701.74596508074, 12905.612831615066, 13189.878860296887, 9957.601695932153, 10062.69811905644, 10067.29528932975, 10085.798284034352, 10088.445135517544, 3459.290845376717, 3484.163800687842, 3487.3548393547276, 3493.807840568768, 3505.404081306159, 63403.0, 82873.58563207145, 83420.16579834184, 83791.0, 83910.0, 9580.66467673628, 9680.419174849532, 9710.368826026286, 9983.450910199863, 10357.378557286587, 20540.281090161774, 20664.0, 20758.273460428813, 20792.0, 20958.371248862557, 7416.629168541552, 7513.624318784039, 7695.0, 7854.0, 7981.281684648409, 4167.229062623424, 4168.645665118499, 4201.096764195651, 4261.936070958938, 4405.052913623586, 3517.806520641338, 3558.87543935961, 3562.608113107608, 3572.9285414291567, 3588.174719814457, 643.5784561112479, 650.5381179362705, 656.2813718977711, 661.0480907493194, 668.909697190873, 532.7842223899327, 538.9730513474389, 610.9999900488668, 621.6580880515698, 636.9299377068519, 8185.672573097128, 8441.66233350659, 8480.194381533744, 8555.14448555152, 8669.26311263537, 501.9046381187563, 517.0202466326291, 584.421422791442, 623.7536173211556, 625.9812205633838, 3821.7515861468914, 3976.4631774710624, 4076.184763047402, 4085.7140000200293, 4093.467849179647, 86537.70193447103, 88200.5589972046, 92944.53527732319, 93540.0, 93598.53200733953, 75336.0, 76076.0980975469, 76136.23863761402, 76776.0, 79841.0, 70253.24366890869, 70419.2958070423, 70825.93761093587, 72534.2746572538, 72667.6366618174, 8729.869051964353, 8817.07420720815, 8836.204741573289, 8870.008496176617, 8918.777030574287, 48470.75764621155, 48505.5149448501, 50667.98664026625, 50684.74657626688, 50825.49174508208, 61664.38335616586, 68370.31629683639, 71625.0, 72322.0, 72517.6374118147, 10779.946100269448, 10798.514066866852, 10916.345019298868, 11251.943740281245, 11290.15323850698, 11766.411679415824, 11879.287242765462, 12188.634340969786, 12379.62594508577, 12652.430640621378, 9075.2286055686, 11121.610743623934, 11169.832452513056, 11436.542538298374, 12131.454084566392, 9423.340366174576, 11192.272502287326, 11470.139739519736, 11597.6520704379, 12253.0, 10261.384316940708, 10820.45897705096, 10880.455977201267, 11137.0, 11268.549258029914, 7607.543547387175, 8769.605367758339, 8822.558872056243, 8828.823423531621, 9425.0, 8829.955850220707, 8879.28965682731, 9016.684416045407, 9107.726768196964, 9487.66793162236], "unit": "score", "name": "yui.html", "value": 6862.34990564834}], "name": "dromaeo_css", "value": 7436.672903876355}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 115.0, 115.0, 115.0, 129.0, 115.0, 114.0, 117.0, 114.0], "unit": "score", "name": "ai-astar", "value": 116.0}, {"lowerIsBetter": true, "replicates": [154.0, 121.0, 135.0, 147.0, 121.0, 147.0, 168.0, 151.0, 158.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [194.0, 197.0, 195.0, 197.0, 196.0, 200.0, 224.0, 195.0, 197.0, 214.0], "unit": "score", "name": "audio-dft", "value": 200.9}, {"lowerIsBetter": true, "replicates": [59.0, 68.0, 70.0, 74.0, 123.0, 56.0, 57.0, 71.0, 88.0, 108.0], "unit": "score", "name": "audio-fft", "value": 77.4}, {"lowerIsBetter": true, "replicates": [86.0, 93.0, 120.0, 77.0, 80.0, 81.0, 117.0, 82.0, 84.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 93.2}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 85.0, 92.0, 85.0, 92.0, 86.0, 96.0, 110.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 95.0}, {"lowerIsBetter": true, "replicates": [146.0, 151.0, 139.0, 80.0, 81.0, 133.0, 108.0, 120.0, 80.0, 136.0], "unit": "score", "name": "imaging-desaturate", "value": 117.4}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 55.0, 57.0, 56.0, 57.0, 55.0, 61.0, 53.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [56.0, 99.0, 64.0, 60.0, 71.0, 100.0, 83.0, 66.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.0}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 86.0, 84.0, 86.0, 83.0, 87.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [131.0, 128.0, 123.0, 111.0, 142.0, 136.0, 137.0, 145.0, 122.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.2}, {"lowerIsBetter": true, "replicates": [128.0, 140.0, 143.0, 141.0, 141.0, 142.0, 152.0, 177.0, 115.0, 177.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.6}, {"lowerIsBetter": true, "replicates": [74.0, 68.0, 66.0, 81.0, 95.0, 75.0, 69.0, 66.0, 66.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.3}], "name": "kraken", "value": 1497.6}]} 05:15:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1497.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7436.67"}}} 05:15:10 INFO - Return code: 0 05:15:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:15:10 INFO - # TBPL SUCCESS # 05:15:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:15:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:15:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:15:10 INFO - 2016-02-16 05:15:10.929 screenresolution[1695:10708] starting screenresolution argv=screenresolution get 05:15:10 INFO - 2016-02-16 05:15:10.931 screenresolution[1695:10708] Display 0: 1600x1200x32@60 05:15:10 INFO - 2016-02-16 05:15:10.937 screenresolution[1696:10711] starting screenresolution argv=screenresolution list 05:15:10 INFO - Available Modes on Display 0 05:15:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:15:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:15:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:15:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:15:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:15:11 INFO - Intel Iris: 05:15:11 INFO - Chipset Model: Intel Iris 05:15:11 INFO - Type: GPU 05:15:11 INFO - Bus: Built-In 05:15:11 INFO - VRAM (Dynamic, Max): 1536 MB 05:15:11 INFO - Vendor: Intel (0x8086) 05:15:11 INFO - Device ID: 0x0a2e 05:15:11 INFO - Revision ID: 0x0009 05:15:11 INFO - Displays: 05:15:11 INFO - Display: 05:15:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:15:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:15:11 INFO - Display Serial Number: 1600x1200 60 05:15:11 INFO - Main Display: Yes 05:15:11 INFO - Mirror: Off 05:15:11 INFO - Online: Yes 05:15:11 INFO - Rotation: Supported 05:15:11 INFO - Return code: 0 05:15:11 INFO - Running post-action listener: _resource_record_post_action 05:15:11 INFO - Running post-run listener: _resource_record_post_run 05:15:12 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 39134720; Write bytes: 711700992; Read time: 420; Write time: 1948 05:15:12 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384692736; Write bytes: 378758656; Read time: 28508; Write time: 653 05:15:12 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 38172160; Write bytes: 305445888; Read time: 405; Write time: 1239 05:15:12 INFO - Running post-run listener: _upload_blobber_files 05:15:12 INFO - Blob upload gear active. 05:15:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:15:12 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 05:15:12 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'] 05:15:12 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 05:15:12 INFO - (blobuploader) - INFO - Open directory for files ... 05:15:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:15:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:15:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:13 INFO - (blobuploader) - INFO - Done attempting. 05:15:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:15:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:15:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:14 INFO - (blobuploader) - INFO - Done attempting. 05:15:14 INFO - (blobuploader) - INFO - Iteration through files over. 05:15:14 INFO - Return code: 0 05:15:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:15:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:15:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aee608192debc740170a0deb4a7869a512200fff3f7be087a5c469cf30bb94e8b98ef3e5edff8d3dff086f06bb9d429db7f6cf1695462560db9be7cf6d5ea4a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8224a608823c3dea515f75b7589dfb1108b9403855d0cf62c83e45bf59d3ec73aec266ef3e9d4a7d6ff34dfd31320301e494db42eb004f884502a693f2714aa6"} 05:15:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:15:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:15:14 INFO - Contents: 05:15:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aee608192debc740170a0deb4a7869a512200fff3f7be087a5c469cf30bb94e8b98ef3e5edff8d3dff086f06bb9d429db7f6cf1695462560db9be7cf6d5ea4a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8224a608823c3dea515f75b7589dfb1108b9403855d0cf62c83e45bf59d3ec73aec266ef3e9d4a7d6ff34dfd31320301e494db42eb004f884502a693f2714aa6"} 05:15:14 INFO - Running post-run listener: copy_logs_to_upload_dir 05:15:14 INFO - Copying logs to upload dir... 05:15:14 INFO - mkdir: /builds/slave/test/build/upload/logs 05:15:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.989730 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-02-16 05:15:14.430672) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 05:15:14.433735) ========= 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.PUW5zjGhQW/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.U5r2da56Ni/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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/aee608192debc740170a0deb4a7869a512200fff3f7be087a5c469cf30bb94e8b98ef3e5edff8d3dff086f06bb9d429db7f6cf1695462560db9be7cf6d5ea4a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8224a608823c3dea515f75b7589dfb1108b9403855d0cf62c83e45bf59d3ec73aec266ef3e9d4a7d6ff34dfd31320301e494db42eb004f884502a693f2714aa6"} build_url:https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/Wh1kKH1NRhK3sesssMjMqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aee608192debc740170a0deb4a7869a512200fff3f7be087a5c469cf30bb94e8b98ef3e5edff8d3dff086f06bb9d429db7f6cf1695462560db9be7cf6d5ea4a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8224a608823c3dea515f75b7589dfb1108b9403855d0cf62c83e45bf59d3ec73aec266ef3e9d4a7d6ff34dfd31320301e494db42eb004f884502a693f2714aa6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 05:15:14.460805) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:15:14.461181) ========= 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.PUW5zjGhQW/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.U5r2da56Ni/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005209 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:15:14.510612) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 05:15:14.511038) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 05:15:14.511583) ========= ========= Total master_lag: 0.68 =========