builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0147 starttime: 1459548616.76 results: success (0) buildid: 20160401130352 builduid: 480ae5b80c3e44159dfdf399d7dfb7e4 revision: faa65506b112a63784802378f8fa5610605c96b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.763508) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.763959) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.764242) ========= 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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.005544 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.788504) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.788773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.805591) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.805866) ========= 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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.005413 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.854007) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.854309) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.854661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.854960) ========= 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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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-04-01 15:10:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.95M=0.002s 2016-04-01 15:10:16 (6.95 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101913 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.972475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:16.972795) ========= 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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.026787 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:17.020811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-01 15:10:17.021169) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev faa65506b112a63784802378f8fa5610605c96b0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev faa65506b112a63784802378f8fa5610605c96b0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8mgG0slxuR/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.4EUvR3C6Mu/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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-04-01 15:10:17,100 truncating revision to first 12 chars 2016-04-01 15:10:17,100 Setting DEBUG logging. 2016-04-01 15:10:17,100 attempt 1/10 2016-04-01 15:10:17,100 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/faa65506b112?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 15:10:17,731 unpacking tar archive at: mozilla-aurora-faa65506b112/testing/mozharness/ program finished with exit code 0 elapsedTime=0.884439 ========= master_lag: 3.00 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-01 15:10:20.910524) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:20.910907) ========= echo faa65506b112a63784802378f8fa5610605c96b0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'faa65506b112a63784802378f8fa5610605c96b0'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8mgG0slxuR/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.4EUvR3C6Mu/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 faa65506b112a63784802378f8fa5610605c96b0 program finished with exit code 0 elapsedTime=0.005949 script_repo_revision: 'faa65506b112a63784802378f8fa5610605c96b0' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:20.940816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:20.941098) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 15:10:20.955135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-04-01 15:10:20.955406) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8mgG0slxuR/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.4EUvR3C6Mu/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 15:10:21 INFO - MultiFileLogger online at 20160401 15:10:21 in /builds/slave/test 15:10:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:10:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:10:21 INFO - {'append_to_log': False, 15:10:21 INFO - 'base_work_dir': '/builds/slave/test', 15:10:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:10:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:10:21 INFO - 'branch': 'Mozilla-Aurora', 15:10:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:10:21 INFO - 'config_files': ('talos/mac_config.py',), 15:10:21 INFO - 'default_actions': ('clobber', 15:10:21 INFO - 'read-buildbot-config', 15:10:21 INFO - 'download-and-extract', 15:10:21 INFO - 'populate-webroot', 15:10:21 INFO - 'create-virtualenv', 15:10:21 INFO - 'install', 15:10:21 INFO - 'run-tests'), 15:10:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:10:21 INFO - 'download_minidump_stackwalk': True, 15:10:21 INFO - 'download_symbols': 'ondemand', 15:10:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:10:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:10:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:10:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:10:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:10:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:10:21 INFO - 'installer_path': 'installer.exe', 15:10:21 INFO - 'log_level': 'info', 15:10:21 INFO - 'log_name': 'talos', 15:10:21 INFO - 'log_to_console': True, 15:10:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:10:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:10:21 INFO - 'opt_config_files': (), 15:10:21 INFO - 'pip_index': False, 15:10:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:10:21 INFO - 'cmd': ('bash', 15:10:21 INFO - '-c', 15:10:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:10:21 INFO - 'enabled': True, 15:10:21 INFO - 'halt_on_failure': False, 15:10:21 INFO - 'name': 'check_screen_resolution'},), 15:10:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:10:21 INFO - 'cmd': ('bash', 15:10:21 INFO - '-c', 15:10:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:10:21 INFO - 'enabled': True, 15:10:21 INFO - 'halt_on_failure': False, 15:10:21 INFO - 'name': 'check_screen_resolution'},), 15:10:21 INFO - 'run_cmd_checks_enabled': True, 15:10:21 INFO - 'sps_profile': False, 15:10:21 INFO - 'sps_profile_interval': 0, 15:10:21 INFO - 'suite': 'dromaeojs-e10s', 15:10:21 INFO - 'system_bits': '32', 15:10:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:10:21 INFO - 'title': 't-yosemite-r7-0147', 15:10:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:10:21 INFO - 'use_talos_json': True, 15:10:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:10:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:10:21 INFO - 'work_dir': 'build'} 15:10:21 INFO - ##### 15:10:21 INFO - ##### Running clobber step. 15:10:21 INFO - ##### 15:10:21 INFO - Running pre-action listener: _resource_record_pre_action 15:10:21 INFO - Running main action method: clobber 15:10:21 INFO - rmtree: /builds/slave/test/build 15:10:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:10:22 INFO - Running post-action listener: _resource_record_post_action 15:10:22 INFO - ##### 15:10:22 INFO - ##### Running read-buildbot-config step. 15:10:22 INFO - ##### 15:10:22 INFO - Running pre-action listener: _resource_record_pre_action 15:10:22 INFO - Running main action method: read_buildbot_config 15:10:22 INFO - Using buildbot properties: 15:10:22 INFO - { 15:10:22 INFO - "project": "", 15:10:22 INFO - "product": "firefox", 15:10:22 INFO - "script_repo_revision": "production", 15:10:22 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 15:10:22 INFO - "repository": "", 15:10:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 15:10:22 INFO - "buildid": "20160401130352", 15:10:22 INFO - "pgo_build": "False", 15:10:22 INFO - "basedir": "/builds/slave/test", 15:10:22 INFO - "buildnumber": 227, 15:10:22 INFO - "slavename": "t-yosemite-r7-0147", 15:10:22 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:10:22 INFO - "platform": "yosemite_r7", 15:10:22 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:10:22 INFO - "branch": "mozilla-aurora", 15:10:22 INFO - "repo_path": "releases/mozilla-aurora", 15:10:22 INFO - "revision": "faa65506b112a63784802378f8fa5610605c96b0", 15:10:22 INFO - "stage_platform": "macosx64", 15:10:22 INFO - "builduid": "480ae5b80c3e44159dfdf399d7dfb7e4", 15:10:22 INFO - "slavebuilddir": "test" 15:10:22 INFO - } 15:10:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 15:10:22 INFO - Running post-action listener: _resource_record_post_action 15:10:22 INFO - ##### 15:10:22 INFO - ##### Running download-and-extract step. 15:10:22 INFO - ##### 15:10:22 INFO - Running pre-action listener: _resource_record_pre_action 15:10:22 INFO - Running main action method: download_and_extract 15:10:22 INFO - mkdir: /builds/slave/test/build/tests 15:10:22 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')]} 15:10:22 INFO - https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:10:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 15:10:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 15:10:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 15:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 15:10:25 INFO - Downloaded 1277 bytes. 15:10:25 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 15:10:25 INFO - Using the following test package requirements: 15:10:25 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 15:10:25 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:10:25 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 15:10:25 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:10:25 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 15:10:25 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:10:25 INFO - u'jsshell-mac.zip'], 15:10:25 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:10:25 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 15:10:25 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 15:10:25 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:10:25 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 15:10:25 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:10:25 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 15:10:25 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:10:25 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 15:10:25 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 15:10:25 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:10:25 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 15:10:25 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:10: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')]} 15:10:25 INFO - https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:10:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 15:10:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 15:10:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 15:10:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:10:26 INFO - Downloaded 17903479 bytes. 15:10:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:10:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:10:30 INFO - Return code: 0 15:10:30 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 15:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:30 INFO - https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:10:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 15:10:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 15:10:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 15:10:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:10:31 INFO - Downloaded 17903479 bytes. 15:10:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:10:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:10:35 INFO - Return code: 0 15:10: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')]} 15:10:35 INFO - https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:10:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 15:10:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 15:10:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 15:10:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 15:10:36 INFO - Downloaded 10845161 bytes. 15:10:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:10:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:10:36 INFO - Return code: 0 15:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:36 INFO - https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 15:10:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 15:10:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 15:10:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 15:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 15:10:39 INFO - Downloaded 115185715 bytes. 15:10:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 15:10:39 INFO - mkdir: /builds/slave/test/properties 15:10:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:10:39 INFO - Writing to file /builds/slave/test/properties/build_url 15:10:39 INFO - Contents: 15:10:39 INFO - build_url:https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 15:10:40 INFO - Running post-action listener: _resource_record_post_action 15:10:40 INFO - Running post-action listener: set_extra_try_arguments 15:10:40 INFO - ##### 15:10:40 INFO - ##### Running populate-webroot step. 15:10:40 INFO - ##### 15:10:40 INFO - Running pre-action listener: _resource_record_pre_action 15:10:40 INFO - Running main action method: populate_webroot 15:10:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:10:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:10:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:10:40 INFO - '--tppagecycles', 15:10:40 INFO - '7'], 15:10:40 INFO - 'tests': ['tsvgm']}}, 15:10:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:10:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:10:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:10:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:10:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:10:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:10:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:40 INFO - 'talos_options': ['--e10s'], 15:10:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:40 INFO - 'tests': ['damp', 'tps']}, 15:10:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:40 INFO - 'talos_options': ['--e10s'], 15:10:40 INFO - 'tests': ['damp', 'tps']}, 15:10:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:10:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:10:40 INFO - 'other': {'tests': ['a11yr', 15:10:40 INFO - 'ts_paint', 15:10:40 INFO - 'tpaint', 15:10:40 INFO - 'sessionrestore', 15:10:40 INFO - 'sessionrestore_no_auto_restore', 15:10:40 INFO - 'tabpaint']}, 15:10:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:10:40 INFO - 'tests': ['a11yr', 15:10:40 INFO - 'ts_paint', 15:10:40 INFO - 'tpaint', 15:10:40 INFO - 'sessionrestore', 15:10:40 INFO - 'sessionrestore_no_auto_restore', 15:10:40 INFO - 'tabpaint']}, 15:10:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:10:40 INFO - 'tests': ['a11yr', 15:10:40 INFO - 'ts_paint', 15:10:40 INFO - 'tpaint', 15:10:40 INFO - 'sessionrestore', 15:10:40 INFO - 'sessionrestore_no_auto_restore', 15:10:40 INFO - 'tabpaint']}, 15:10:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:10:40 INFO - 'tests': ['a11yr', 15:10:40 INFO - 'ts_paint', 15:10:40 INFO - 'tpaint', 15:10:40 INFO - 'sessionrestore', 15:10:40 INFO - 'sessionrestore_no_auto_restore', 15:10:40 INFO - 'tabpaint']}, 15:10:40 INFO - 'other_l64': {'tests': ['a11yr', 15:10:40 INFO - 'ts_paint', 15:10:40 INFO - 'tpaint', 15:10:40 INFO - 'sessionrestore', 15:10:40 INFO - 'sessionrestore_no_auto_restore', 15:10:40 INFO - 'tabpaint']}, 15:10:40 INFO - 'other_nol64': {'tests': ['a11yr', 15:10:40 INFO - 'ts_paint', 15:10:40 INFO - 'tpaint', 15:10:40 INFO - 'sessionrestore', 15:10:40 INFO - 'sessionrestore_no_auto_restore', 15:10:40 INFO - 'tabpaint']}, 15:10:40 INFO - 'svgr': {'tests': ['tsvgx', 15:10:40 INFO - 'tsvgr_opacity', 15:10:40 INFO - 'tart', 15:10:40 INFO - 'tscrollx', 15:10:40 INFO - 'cart']}, 15:10:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:10:40 INFO - 'tests': ['tsvgx', 15:10:40 INFO - 'tsvgr_opacity', 15:10:40 INFO - 'tart', 15:10:40 INFO - 'tscrollx', 15:10:40 INFO - 'cart']}, 15:10:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:40 INFO - 'tests': ['tp5o']}, 15:10:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:40 INFO - 'talos_options': ['--e10s'], 15:10:40 INFO - 'tests': ['tp5o']}, 15:10:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:40 INFO - 'talos_options': ['--xperf_path', 15:10:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:40 INFO - 'tests': ['tp5n']}, 15:10:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:40 INFO - 'talos_options': ['--e10s', 15:10:40 INFO - '--xperf_path', 15:10:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:40 INFO - 'tests': ['tp5n']}}, 15:10:40 INFO - 'talos.zip': {'path': '', 15:10:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:10:40 INFO - Running post-action listener: _resource_record_post_action 15:10:40 INFO - ##### 15:10:40 INFO - ##### Running create-virtualenv step. 15:10:40 INFO - ##### 15:10:40 INFO - Running pre-action listener: _resource_record_pre_action 15:10:40 INFO - Running main action method: create_virtualenv 15:10:40 INFO - Creating virtualenv /builds/slave/test/build/venv 15:10:40 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 15:10:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:10:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:10:40 INFO - Using real prefix '/tools/python27' 15:10:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:10:41 INFO - Installing distribute.............................................................................................................................................................................................done. 15:10:44 INFO - Installing pip.................done. 15:10:44 INFO - Return code: 0 15:10:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:10:44 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')]} 15:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:44 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')]} 15:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:44 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 0x10e552a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feccb4a1050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f6d30>, '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 0x10e25adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3edb20>, '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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 15:10:44 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 15:10:44 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 15:10:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mgG0slxuR/Render', 15:10:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:44 INFO - 'HOME': '/Users/cltbld', 15:10:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:44 INFO - 'LOGNAME': 'cltbld', 15:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:44 INFO - 'MOZ_NO_REMOTE': '1', 15:10:44 INFO - 'NO_EM_RESTART': '1', 15:10:44 INFO - 'PAGER': '/bin/cat', 15:10:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:44 INFO - 'PWD': '/builds/slave/test', 15:10:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:44 INFO - 'SHELL': '/bin/bash', 15:10:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EUvR3C6Mu/Listeners', 15:10:44 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 15:10:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:44 INFO - 'USER': 'cltbld', 15:10:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:44 INFO - 'XPC_FLAGS': '0x0', 15:10:44 INFO - 'XPC_SERVICE_NAME': '0', 15:10:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:44 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 15:10:44 INFO - Cleaning up... 15:10:44 INFO - Return code: 0 15:10:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:10:44 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')]} 15:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:44 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')]} 15:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:44 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 0x10e552a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feccb4a1050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f6d30>, '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 0x10e25adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3edb20>, '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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 15:10:44 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 15:10:44 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 15:10:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mgG0slxuR/Render', 15:10:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:44 INFO - 'HOME': '/Users/cltbld', 15:10:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:44 INFO - 'LOGNAME': 'cltbld', 15:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:44 INFO - 'MOZ_NO_REMOTE': '1', 15:10:44 INFO - 'NO_EM_RESTART': '1', 15:10:44 INFO - 'PAGER': '/bin/cat', 15:10:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:44 INFO - 'PWD': '/builds/slave/test', 15:10:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:44 INFO - 'SHELL': '/bin/bash', 15:10:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EUvR3C6Mu/Listeners', 15:10:44 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 15:10:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:44 INFO - 'USER': 'cltbld', 15:10:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:44 INFO - 'XPC_FLAGS': '0x0', 15:10:44 INFO - 'XPC_SERVICE_NAME': '0', 15:10:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:44 INFO - Downloading/unpacking psutil>=0.7.1 15:10:44 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 15:10:44 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 15:10:44 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 15:10:44 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 15:10:44 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 15:10:44 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 15:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:10:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:47 INFO - Installing collected packages: psutil 15:10:47 INFO - Running setup.py install for psutil 15:10:47 INFO - building 'psutil._psutil_osx' extension 15:10:47 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 15:10:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:10:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:10:48 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 15:10:48 INFO - building 'psutil._psutil_posix' extension 15:10:48 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 15:10:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:10:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:10:48 INFO - ^ 15:10:48 INFO - 1 warning generated. 15:10:48 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 15:10:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:48 INFO - Successfully installed psutil 15:10:48 INFO - Cleaning up... 15:10:48 INFO - Return code: 0 15:10:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:48 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 0x10e552a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feccb4a1050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f6d30>, '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 0x10e25adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3edb20>, '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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 15:10:48 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 15:10:48 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 15:10:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mgG0slxuR/Render', 15:10:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:48 INFO - 'HOME': '/Users/cltbld', 15:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:48 INFO - 'LOGNAME': 'cltbld', 15:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:48 INFO - 'MOZ_NO_REMOTE': '1', 15:10:48 INFO - 'NO_EM_RESTART': '1', 15:10:48 INFO - 'PAGER': '/bin/cat', 15:10:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:48 INFO - 'PWD': '/builds/slave/test', 15:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:48 INFO - 'SHELL': '/bin/bash', 15:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EUvR3C6Mu/Listeners', 15:10:48 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 15:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:48 INFO - 'USER': 'cltbld', 15:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:48 INFO - 'XPC_FLAGS': '0x0', 15:10:48 INFO - 'XPC_SERVICE_NAME': '0', 15:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:10:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:10:51 INFO - Installing collected packages: mozsystemmonitor 15:10:51 INFO - Running setup.py install for mozsystemmonitor 15:10:51 INFO - Successfully installed mozsystemmonitor 15:10:51 INFO - Cleaning up... 15:10:51 INFO - Return code: 0 15:10:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:10:51 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')]} 15:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:51 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')]} 15:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:51 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 0x10e552a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feccb4a1050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f6d30>, '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 0x10e25adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3edb20>, '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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 15:10:51 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 15:10:51 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 15:10:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mgG0slxuR/Render', 15:10:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:51 INFO - 'HOME': '/Users/cltbld', 15:10:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:51 INFO - 'LOGNAME': 'cltbld', 15:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:51 INFO - 'MOZ_NO_REMOTE': '1', 15:10:51 INFO - 'NO_EM_RESTART': '1', 15:10:51 INFO - 'PAGER': '/bin/cat', 15:10:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:51 INFO - 'PWD': '/builds/slave/test', 15:10:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:51 INFO - 'SHELL': '/bin/bash', 15:10:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EUvR3C6Mu/Listeners', 15:10:51 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 15:10:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:51 INFO - 'USER': 'cltbld', 15:10:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:51 INFO - 'XPC_FLAGS': '0x0', 15:10:51 INFO - 'XPC_SERVICE_NAME': '0', 15:10:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:51 INFO - Downloading/unpacking blobuploader==1.2.4 15:10:51 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 15:10:51 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 15:10:51 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 15:10:51 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 15:10:51 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 15:10:51 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 15:10:54 INFO - Downloading blobuploader-1.2.4.tar.gz 15:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:10:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:10: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 15:10: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 15:10: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 15:10: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 15:10: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 15:10: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 15:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:10:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:10: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 15:10: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 15:10: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 15:10: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 15:10: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 15:10: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 15:10:55 INFO - Downloading docopt-0.6.1.tar.gz 15:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:10:55 INFO - Installing collected packages: blobuploader, requests, docopt 15:10:55 INFO - Running setup.py install for blobuploader 15:10:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:10:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:10:55 INFO - Running setup.py install for requests 15:10:56 INFO - Running setup.py install for docopt 15:10:56 INFO - Successfully installed blobuploader requests docopt 15:10:56 INFO - Cleaning up... 15:10:56 INFO - Return code: 0 15:10:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:56 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 0x10e552a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feccb4a1050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f6d30>, '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 0x10e25adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3edb20>, '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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 15:10:56 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 15:10:56 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 15:10:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mgG0slxuR/Render', 15:10:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:56 INFO - 'HOME': '/Users/cltbld', 15:10:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:56 INFO - 'LOGNAME': 'cltbld', 15:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:56 INFO - 'MOZ_NO_REMOTE': '1', 15:10:56 INFO - 'NO_EM_RESTART': '1', 15:10:56 INFO - 'PAGER': '/bin/cat', 15:10:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:56 INFO - 'PWD': '/builds/slave/test', 15:10:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:56 INFO - 'SHELL': '/bin/bash', 15:10:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EUvR3C6Mu/Listeners', 15:10:56 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 15:10:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:56 INFO - 'USER': 'cltbld', 15:10:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:56 INFO - 'XPC_FLAGS': '0x0', 15:10:56 INFO - 'XPC_SERVICE_NAME': '0', 15:10:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:56 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-LAY8OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:56 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-xPTG93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:56 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-X_a_7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:56 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-8vy913-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:57 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-F7vlAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:57 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-rLuRWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:57 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-PvuCTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:57 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-7BJhjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:57 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-wAZVVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:57 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-xacN1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:57 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-3tPgp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:57 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-V3lTmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:57 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-YHJkBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:57 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-8Offno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:58 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-KMJkzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:58 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-uvI7kJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:58 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-kARxvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:10:58 INFO - Running setup.py install for manifestparser 15:10:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:10:58 INFO - Running setup.py install for mozcrash 15:10:58 INFO - Running setup.py install for mozdebug 15:10:58 INFO - Running setup.py install for mozdevice 15:10:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:10:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:10:59 INFO - Running setup.py install for mozfile 15:10:59 INFO - Running setup.py install for mozhttpd 15:10:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:10:59 INFO - Running setup.py install for mozinfo 15:10:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:10:59 INFO - Running setup.py install for mozInstall 15:10:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:10:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:10:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:10:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:10:59 INFO - Running setup.py install for mozleak 15:10:59 INFO - Running setup.py install for mozlog 15:10:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:10:59 INFO - Running setup.py install for moznetwork 15:11:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:11:00 INFO - Running setup.py install for mozprocess 15:11:00 INFO - Running setup.py install for mozprofile 15:11:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:11:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:11:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:11:00 INFO - Running setup.py install for mozrunner 15:11:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:11:00 INFO - Running setup.py install for mozscreenshot 15:11:00 INFO - Running setup.py install for moztest 15:11:00 INFO - Running setup.py install for mozversion 15:11:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:11:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:11:00 INFO - Cleaning up... 15:11:00 INFO - Return code: 0 15:11:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:00 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 0x10e552a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feccb4a1050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f6d30>, '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 0x10e25adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3edb20>, '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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 15:11:00 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 15:11:00 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 15:11:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mgG0slxuR/Render', 15:11:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:00 INFO - 'HOME': '/Users/cltbld', 15:11:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:00 INFO - 'LOGNAME': 'cltbld', 15:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:00 INFO - 'MOZ_NO_REMOTE': '1', 15:11:00 INFO - 'NO_EM_RESTART': '1', 15:11:00 INFO - 'PAGER': '/bin/cat', 15:11:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:00 INFO - 'PWD': '/builds/slave/test', 15:11:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:00 INFO - 'SHELL': '/bin/bash', 15:11:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EUvR3C6Mu/Listeners', 15:11:00 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 15:11:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:00 INFO - 'USER': 'cltbld', 15:11:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:00 INFO - 'XPC_FLAGS': '0x0', 15:11:00 INFO - 'XPC_SERVICE_NAME': '0', 15:11:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:11:01 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-LzOMtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:11:01 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)) 15:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:11:01 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Xnv2Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:11:01 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-xBuse7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:11:01 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)) 15:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:11:01 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-bpHYp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:11:01 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)) 15:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:11:01 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Jn2N_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:11:01 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)) 15:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:11:01 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-YfyUO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:11:01 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)) 15:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:11:01 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-VGcMEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:11:01 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)) 15:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:11:01 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-INPG0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:11:02 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-vWYclj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:11:02 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-z1PCaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:11:02 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)) 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:11:02 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-747B_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:11:02 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)) 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:11:02 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-SI5Gmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:11:02 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)) 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:11:02 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-MAk3fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:11:02 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)) 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:11:02 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-XaSuVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:11:02 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)) 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:02 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-HOzyiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:02 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)) 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:11:02 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-pSxKa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:11:02 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)) 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:11:02 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-2LpQ9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:11:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11:05 INFO - Downloading blessings-1.6.tar.gz 15:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:11:05 INFO - Installing collected packages: blessings 15:11:05 INFO - Running setup.py install for blessings 15:11:05 INFO - Successfully installed blessings 15:11:05 INFO - Cleaning up... 15:11:05 INFO - Return code: 0 15:11:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:06 INFO - Reading from file tmpfile_stdout 15:11:06 INFO - Current package versions: 15:11:06 INFO - blessings == 1.6 15:11:06 INFO - blobuploader == 1.2.4 15:11:06 INFO - docopt == 0.6.1 15:11:06 INFO - manifestparser == 1.1 15:11:06 INFO - mozInstall == 1.12 15:11:06 INFO - mozcrash == 0.17 15:11:06 INFO - mozdebug == 0.1 15:11:06 INFO - mozdevice == 0.48 15:11:06 INFO - mozfile == 1.2 15:11:06 INFO - mozhttpd == 0.7 15:11:06 INFO - mozinfo == 0.9 15:11:06 INFO - mozleak == 0.1 15:11:06 INFO - mozlog == 3.1 15:11:06 INFO - moznetwork == 0.27 15:11:06 INFO - mozprocess == 0.22 15:11:06 INFO - mozprofile == 0.28 15:11:06 INFO - mozrunner == 6.11 15:11:06 INFO - mozscreenshot == 0.1 15:11:06 INFO - mozsystemmonitor == 0.0 15:11:06 INFO - moztest == 0.7 15:11:06 INFO - mozversion == 1.4 15:11:06 INFO - psutil == 3.1.1 15:11:06 INFO - requests == 1.2.3 15:11:06 INFO - wsgiref == 0.1.2 15:11:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e552a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feccb4a1050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f6d30>, '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 0x10e25adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3edb20>, '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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 15:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:11:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mgG0slxuR/Render', 15:11:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:06 INFO - 'HOME': '/Users/cltbld', 15:11:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:06 INFO - 'LOGNAME': 'cltbld', 15:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:06 INFO - 'MOZ_NO_REMOTE': '1', 15:11:06 INFO - 'NO_EM_RESTART': '1', 15:11:06 INFO - 'PAGER': '/bin/cat', 15:11:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:06 INFO - 'PWD': '/builds/slave/test', 15:11:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:06 INFO - 'SHELL': '/bin/bash', 15:11:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EUvR3C6Mu/Listeners', 15:11:06 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 15:11:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:06 INFO - 'USER': 'cltbld', 15:11:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:06 INFO - 'XPC_FLAGS': '0x0', 15:11:06 INFO - 'XPC_SERVICE_NAME': '0', 15:11:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:06 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)) 15:11:06 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)) 15:11:06 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)) 15:11:06 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)) 15:11:06 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)) 15:11:06 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)) 15:11:06 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)) 15:11:06 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)) 15:11:06 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)) 15:11:06 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)) 15:11:06 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)) 15:11:06 INFO - Cleaning up... 15:11:06 INFO - Return code: 0 15:11:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:06 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 0x10e552a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feccb4a1050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f6d30>, '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 0x10e25adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3edb20>, '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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 15:11:06 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 15:11:06 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 15:11:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mgG0slxuR/Render', 15:11:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:06 INFO - 'HOME': '/Users/cltbld', 15:11:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:06 INFO - 'LOGNAME': 'cltbld', 15:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:06 INFO - 'MOZ_NO_REMOTE': '1', 15:11:06 INFO - 'NO_EM_RESTART': '1', 15:11:06 INFO - 'PAGER': '/bin/cat', 15:11:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:06 INFO - 'PWD': '/builds/slave/test', 15:11:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:06 INFO - 'SHELL': '/bin/bash', 15:11:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EUvR3C6Mu/Listeners', 15:11:06 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 15:11:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:06 INFO - 'USER': 'cltbld', 15:11:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:06 INFO - 'XPC_FLAGS': '0x0', 15:11:06 INFO - 'XPC_SERVICE_NAME': '0', 15:11:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:06 INFO - Downloading/unpacking jsonschema 15:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:11:08 INFO - Downloading/unpacking functools32 (from jsonschema) 15:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:09 INFO - Downloading functools32-3.2.3-2.tar.gz 15:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:11:09 INFO - warning: no files found matching '*.txt' 15:11:09 INFO - no previously-included directories found matching 'build' 15:11:09 INFO - no previously-included directories found matching 'dist' 15:11:09 INFO - no previously-included directories found matching '.git*' 15:11:09 INFO - Installing collected packages: jsonschema, functools32 15:11:09 INFO - Running setup.py install for functools32 15:11:09 INFO - warning: no files found matching '*.txt' 15:11:09 INFO - no previously-included directories found matching 'build' 15:11:09 INFO - no previously-included directories found matching 'dist' 15:11:09 INFO - no previously-included directories found matching '.git*' 15:11:09 INFO - Successfully installed jsonschema functools32 15:11:09 INFO - Cleaning up... 15:11:09 INFO - Return code: 0 15:11:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:11:09 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')]} 15:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:09 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')]} 15:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:09 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 0x10e552a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feccb4a1050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f6d30>, '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 0x10e25adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3edb20>, '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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 15:11:09 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 15:11:09 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 15:11:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mgG0slxuR/Render', 15:11:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:09 INFO - 'HOME': '/Users/cltbld', 15:11:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:09 INFO - 'LOGNAME': 'cltbld', 15:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:09 INFO - 'MOZ_NO_REMOTE': '1', 15:11:09 INFO - 'NO_EM_RESTART': '1', 15:11:09 INFO - 'PAGER': '/bin/cat', 15:11:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:09 INFO - 'PWD': '/builds/slave/test', 15:11:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:09 INFO - 'SHELL': '/bin/bash', 15:11:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EUvR3C6Mu/Listeners', 15:11:09 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 15:11:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:09 INFO - 'USER': 'cltbld', 15:11:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:09 INFO - 'XPC_FLAGS': '0x0', 15:11:09 INFO - 'XPC_SERVICE_NAME': '0', 15:11:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:10 INFO - Downloading/unpacking flake8 15:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:11:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:11:12 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 15:11:12 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 15:11:12 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 15:11:12 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 15:11:12 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 15:11:12 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 15:11:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:11:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:11:12 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 15:11:12 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 15:11:12 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 15:11:12 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 15:11:12 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 15:11:12 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 15:11:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:11:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:11:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:11:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:11:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:11:13 INFO - no previously-included directories found matching 'docs/_build' 15:11:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:11:13 INFO - Running setup.py install for pep8 15:11:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:11:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:11:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:11:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:11:13 INFO - no previously-included directories found matching 'docs/_build' 15:11:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:11:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:11:14 INFO - Cleaning up... 15:11:14 INFO - Return code: 0 15:11:14 INFO - Running post-action listener: _resource_record_post_action 15:11:14 INFO - Running post-action listener: _start_resource_monitoring 15:11:14 INFO - Starting resource monitoring. 15:11:14 INFO - ##### 15:11:14 INFO - ##### Running install step. 15:11:14 INFO - ##### 15:11:14 INFO - Running pre-action listener: _resource_record_pre_action 15:11:14 INFO - Running main action method: install 15:11:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:14 INFO - Reading from file tmpfile_stdout 15:11:14 INFO - Detecting whether we're running mozinstall >=1.0... 15:11:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:11:14 INFO - Reading from file tmpfile_stdout 15:11:14 INFO - Output received: 15:11:14 INFO - Usage: mozinstall [options] installer 15:11:14 INFO - Options: 15:11:14 INFO - -h, --help show this help message and exit 15:11:14 INFO - -d DEST, --destination=DEST 15:11:14 INFO - Directory to install application into. [default: 15:11:14 INFO - "/builds/slave/test"] 15:11:14 INFO - --app=APP Application being installed. [default: firefox] 15:11:14 INFO - mkdir: /builds/slave/test/build/application 15:11:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 15:11:46 INFO - Reading from file tmpfile_stdout 15:11:46 INFO - Output received: 15:11:46 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:11:46 INFO - Running post-action listener: _resource_record_post_action 15:11:46 INFO - ##### 15:11:46 INFO - ##### Running run-tests step. 15:11:46 INFO - ##### 15:11:46 INFO - Running pre-action listener: _resource_record_pre_action 15:11:46 INFO - Running main action method: run_tests 15:11:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:11:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:11:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:11:46 INFO - 2016-04-01 15:11:46.137 screenresolution[1641:7448] starting screenresolution argv=screenresolution get 15:11:46 INFO - 2016-04-01 15:11:46.139 screenresolution[1641:7448] Display 0: 1600x1200x32@60 15:11:46 INFO - 2016-04-01 15:11:46.145 screenresolution[1642:7451] starting screenresolution argv=screenresolution list 15:11:46 INFO - Available Modes on Display 0 15:11:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:11:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:11:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:11:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:11:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:11:46 INFO - Intel Iris: 15:11:46 INFO - Chipset Model: Intel Iris 15:11:46 INFO - Type: GPU 15:11:46 INFO - Bus: Built-In 15:11:46 INFO - VRAM (Dynamic, Max): 1536 MB 15:11:46 INFO - Vendor: Intel (0x8086) 15:11:46 INFO - Device ID: 0x0a2e 15:11:46 INFO - Revision ID: 0x0009 15:11:46 INFO - Displays: 15:11:46 INFO - Display: 15:11:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:11:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:11:46 INFO - Display Serial Number: 1600x1200 60 15:11:46 INFO - Main Display: Yes 15:11:46 INFO - Mirror: Off 15:11:46 INFO - Online: Yes 15:11:46 INFO - Rotation: Supported 15:11:46 INFO - Return code: 0 15:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:11:46 INFO - Python 2.7.3 15:11:46 INFO - Return code: 0 15:11:46 INFO - grabbing minidump binary from tooltool 15:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:46 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f6d30>, '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 0x10e25adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3edb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:11:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:11:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:11:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:11:46 INFO - Return code: 0 15:11:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:11:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:11:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:11:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:11:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:11:47 INFO - Return code: 0 15:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0147', '--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 15:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0147 --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 15:11:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mgG0slxuR/Render', 15:11:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:47 INFO - 'HOME': '/Users/cltbld', 15:11:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:47 INFO - 'LOGNAME': 'cltbld', 15:11:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:11:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:47 INFO - 'MOZ_NO_REMOTE': '1', 15:11:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:11:47 INFO - 'NO_EM_RESTART': '1', 15:11:47 INFO - 'PAGER': '/bin/cat', 15:11:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:47 INFO - 'PWD': '/builds/slave/test', 15:11:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:11:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:47 INFO - 'SHELL': '/bin/bash', 15:11:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EUvR3C6Mu/Listeners', 15:11:47 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 15:11:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:47 INFO - 'USER': 'cltbld', 15:11:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:47 INFO - 'XPC_FLAGS': '0x0', 15:11:47 INFO - 'XPC_SERVICE_NAME': '0', 15:11:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0147', '--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 15:11:47 INFO - mozversion application_buildid: 20160401130352 15:11:47 INFO - mozversion application_changeset: faa65506b112a63784802378f8fa5610605c96b0 15:11:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:11:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:11:47 INFO - mozversion application_name: Firefox 15:11:47 INFO - mozversion application_remotingname: firefox-dev 15:11:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:11:47 INFO - mozversion application_vendor: Mozilla 15:11:47 INFO - mozversion application_version: 47.0a2 15:11:47 INFO - mozversion platform_buildid: 20160401130352 15:11:47 INFO - mozversion platform_changeset: faa65506b112a63784802378f8fa5610605c96b0 15:11:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:11:47 INFO - mozversion platform_version: 47.0a2 15:11:47 INFO - using testdate: 1459548707 15:11:47 INFO - actual date: 1459548707 15:11:47 INFO - starting webserver on 'localhost:49283' 15:11:47 INFO - SUITE-START | Running 2 tests 15:11:47 INFO - TEST-START | dromaeo_css 15:11:47 INFO - operating with platform_type : mac_ 15:11:47 INFO - Initialising browser for dromaeo_css test... 15:11:47 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmp3QPfi8/profile http://localhost:49283/getInfo.html) 15:11:50 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 15:11:50 INFO - PROCESS | 1660 | colorDepth:24 15:11:50 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 15:11:50 INFO - PROCESS | 1660 | __metrics 15:11:50 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:11:51 INFO - TEST-INFO | 1660: exit 0 15:11:51 INFO - Browser initialized. 15:11:51 INFO - Running cycle 1/1 for dromaeo_css test... 15:11:51 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmp3QPfi8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:12:03 INFO - PROCESS | 1663 | RSS: Main: 220041216 15:12:03 INFO - PROCESS | 1663 | 15:12:53 INFO - PROCESS | 1663 | 1459548773102 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] 15:15:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 15:15:05 INFO - PROCESS | 1663 | RSS: Main: 231411712 15:15:05 INFO - PROCESS | 1663 | 15:18:07 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 15:18:07 INFO - PROCESS | 1663 | RSS: Main: 242688000 15:18:07 INFO - PROCESS | 1663 | 15:21:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 15:21:10 INFO - PROCESS | 1663 | RSS: Main: 244228096 15:21:10 INFO - PROCESS | 1663 | 15:24:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 15:24:12 INFO - PROCESS | 1663 | RSS: Main: 246435840 15:24:12 INFO - PROCESS | 1663 | 15:27:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 15:27:15 INFO - PROCESS | 1663 | RSS: Main: 249556992 15:27:15 INFO - PROCESS | 1663 | 15:30:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 15:30:17 INFO - PROCESS | 1663 | RSS: Main: 251285504 15:30:17 INFO - PROCESS | 1663 | 15:30:17 INFO - PROCESS | 1663 | __start_tp_report 15:30:17 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 15:30:17 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 15:30:17 INFO - PROCESS | 1663 | |i|pagename|runs| 15:30:17 INFO - PROCESS | 1663 | |0;dojo.html;2953.8523073846304;3543.6102028776836;3567.464880267958;3599.1362073102464;3610.729195310351;3950.032242100686;5851.122331650249;5908;5919.763209471626;5923.61496502727;4780.450248221456;5951.791687290945;5951.9107213391835;5954.31525374581;5970.8805823883495;4270.3807947847545;5238.292830467876;5310.15037593985;5340.599455040868;5384.488473595022;5302.6023048271345;5395.892082158354;5452.91820622691;5493.423190564973;5515.255440515519;5405.081136206854;5412.323459567554;5418.078926582471;5423.9694458052845;5443.482869127446;5387.326584176978;5402.6758394496455;5443.918341224885;5464.562834973212;5518.972405137949;5292.823551028723;5393.1370980643305;5407.864803379907;5432.511074003359;5462.153366228241;5633;5784.392638772911;5835.270591176103;5876.588638795286;5959.791407300767;6150.938490615082;6189.38106189382;6230.470410015154;6244.718987645567;6288.496920246369;6244.937550624481;6306.590071645328;6310.33741457145;6310.495160387158;6314.179156709644;5052.898942021176;5872.823815285506;5953.226080609493;6018.96990515049;6034.155218269446;6342.953412686855;6343;6343.492520598341;6345.270293916166;6350.968245158745;6282.057691346335;6291.182146321041;6293.496520278367;6296.212973378328;6305.873882522415;5294.311739473844;6209.06863970399;6269.7178626961895;6299.118123462719;6319.368063193736;6258;6258.687065646699;6262.968685156545;6267.592606480564;6303.338149494329;6230.7507699691505;6259.342769009279;6302.810915672537;6303.117563541108;6304.211973503312;4917.704937703749;4974.527419895104;5004.574611158019;5004.9499505005215;5046.545810877039;4492.865214043584;4501.68488205829;4503.549645035536;4521.434820647419;4525.072360166158;5744.023516002289;5896.262967129109;5943.049112142036;5944.405559444108;5949.6430214187285;6182.072689096672;6210.7515699372425;6241.843953901189;6268.247810262797;6308.495320374359;4646.581807637329;5588.580856435784;5950.613210141327;5957.106434034843;5961.910571341434;5468.125099983983;5502.669839809624;5503.6147469677535;5506.201600767866;5523.6685798852195;6319.399657032666;6393.456556192683;6423.13287706163;6490.091387205889;6492.091107245084;6290.025046117859;6299.023651334051;6311.96844015777;6317.463015643538;6326.6520341381665;6344.206974128234;6436.034594810816;6466.547341686037;6484.448821850006;6492.383223593751;6236.781712640217;6257.186565746424;6295.276043255084;6313.936860631518;6320.178376810985;6255.280642726145;6291.591046581958;6295.3704629538515;6298.275698294755;6314.494840412848;5854.824355269348;6119.959572021022;6258.249010118633;6267.185265915402;6267.780627678009;6138.51101655979;6250.1874756281395;6277.71750271248;6285.182926219562;6306.527010474325;5608.653923058355;6060.484878780305;6109.847253818512;6188.535859810442;6203.782867599793;6167.629942203482;6174.938250617436;6191.9690401547705;6261;6267.717952692231;6168.0439531872635;6175.722092505938;6195.628262304276;6199.969000154971;6206.131141640264 15:30:17 INFO - PROCESS | 1663 | |1;ext.html;554.9972250138749;562.6427218716117;588.6085752974273;668.2825139391764;682.3756263019337;39247.60752392475;39800.60199398005;39879.60120398795;40036.59871904487;40043.79978100109;34159.80440684577;41843.95390115248;42008.57991420085;42388;42490.57509424905;9468.621255149803;9687;9696.46669433181;9716;9724.367916085466;9565.473898935556;9698.078682525149;9802.313838031305;9802.852957205647;9813.558389872438;9718.465484398355;9719.757006074835;9788.021197880225;9804.754881127958;9809.558569864374;9740.659076932308;9774;9813.460259685715;9815.460149691764;9816.361936474106;9606.423614583078;9703.369280996712;9720.854187187198;9732.513374331254;9768.51157442125;34574.308513829834;41138.38292425616;41289.58710412888;41529.961750956165;41533;3115.937681246385;3124.390743804959;3223.0814217948005;3285.162283617662;3461.809600471973;27500.449991000267;27873.442531149263;28894.42211155765;29036.70963290361;29448.263793405335;2776.0561409120996;2821.7883658725473;2831.674357448899;2860.3278229616026;2881.1644623059287;421194;422803;423712.88143559394;424410;429314;49604.0079198414;72606.63696681483;72678.18304542323;73107.26892731004;73176;42724.50464233799;44119;48634.75682621635;48760.26859597109;48982.26526602104;16385.01689898586;16516.339346426248;16808;17039.48881533556;17060.658786824195;13473.595792126252;13540.526081587097;13558.796618050737;13572.457101715821;13608.727825443633;13950.232737199349;15780.92109539445;15925.601859953362;15929.203539822962;15997.600059998593;6574.967125164344;6694.966525167343;6731.966340168366;6744.932550674529;6745.5952642841585;950.2018304624149;966.3042609321277;1063.330102035728;1154.8383226348317;1220.4446976625613;30124.84937575342;30286.788528459056;30417.239569010508;30950.84524577408;30993.535096973563;1180.976380472403;1203.272020427646;1228.8586812516676;1250.7123361626877;1306.405585458614;14693.853061469463;15698.68602627941;15703.979241349276;15903.52289431319;15999.360025598846;506712;508738;509889;511495.442522785;512639;64426.6778666113;64531.74138905116;64987.35012649813;65260.67369663122;65324.673376633764;1535.6698309863432;1538.30007346657;1564.1631727025986;1579.0762403993792;1582.327510807902;25280;30231.69768302377;30271.394572108875;30708.385832282784;30743.538846917763;56817;57045.42954570567;57132.71433642805;57227;57418.42581574298;474750;475459;485853;488136;489397;34410.827945861114;34475.82762086173;35696.28607427889;35748.28503429865;36316.636833631324;43507;45378.77310613426;47496;48449.757751212426;49929;39581.80209098936;40354.596454036255;42841.1431771369;43305.783471082446;44482;39017;39238.41142382924;39609.40585891157;40399.19201615892;40493.19013619652;38850.6114938847;39102.82691519259;39434.2113157741;39921.60078399179;40014.39978400268;32263.35473290474;35055.82472087623;35058.721183123016;35177.82411087928;35262.47106293459;26153.476930460904;26179.476410471303;26314;26575.867120664272;33690.98927032193 15:30:17 INFO - PROCESS | 1663 | |2;jquery.html;373.7029061895791;377.5035827886329;382.6785500179849;383.5244297071632;383.8829157107083;17045.659086818272;20564;21706.89146554269;22527.54944901101;22530.324090277318;21058.684119738176;21573.892130539327;21791.128354865785;21805.781942180613;21822.345329640135;4618.284165954283;5817.185594016841;6096.51227901769;6105.20632317798;6106.908396374058;4514.729116253019;6493.6103833769885;6499.9350006500035;6535.60786352818;6543.411093001629;5435.809746658868;5526.944730552704;6374.617522948614;6434.839129021765;6462.838429039265;5625.971870140644;5666.631668941526;5703.914441283343;5716.028275193227;5730.4269573042775;5365.704886231256;5491.533219676332;5592.6085174037835;5643;5654.830355089354;13605.251711155883;13837.30813459323;13946.86053139476;25656.486870262677;25677.743222567722;1822.527636689562;2133.871967681944;2144.785521447858;2210.502636906683;2248.8313376496662;10314.38113713172;10314.9484252579;11832.053435725122;14341.78487322691;14683.045602035834;1744.476657002894;1750.4136114401563;1815.8819676721102;1837.8345948864533;1880.0693656639914;87479.56260218722;90224.09775902223;93002;93339;94150;11521.596744114084;11695.473703683354;11849.401984392669;11849.763004739856;11865.881341186478;12697.793709597574;13875.514356997457;14134.717305654034;14187.077839940372;14206.431742730381;8641.524716140548;9072;9136.634534618674;9185.081491850762;9219.21636660878;9466.242700583936;9484.952575237217;9509.429434233829;9514.952425237829;9551.570179341947;4512.120136573402;4600.97699511507;4610.354550362952;4622;4675.322078298627;1902.1060101752155;1930.4401723500027;1947.2113793913488;1951.1414977409895;1976.2193933396227;710.1620088295861;920.2637889688223;953.5422996961497;962.1965658674944;965.1458459263603;18084.547886302684;18473.815261847478;19301.03494825253;19738;19777.40667779969;955.302629080775;998.7103739915489;999.6001599360314;1002.8646132771983;1035.420164707751;8754.51850148248;9298.628054877729;10630.681079567625;10643.148548116287;10681.359118452918;655727;658510;663449;672974;675544;102637;108349.45825270824;111589.44205279084;114433;116508;999.7500624843789;1024.4007255755466;1024.9795004099876;1034.8085604163255;1062.7130674717628;17461.650766984843;17539.386121485688;17644.382446614305;17849.37527186542;18126.274949002418;41632.16735665209;49850.750746246034;51844.481555183964;52126.21810672767;52410.95178096493;65567.01649475166;71057.64471177818;71434.28565714277;74657.50684986162;75884;7186.568805871664;8138;8299.834003319778;8311.293540049164;8388.163646627978;12183.512659493521;13722.931385343009;13755.862441375859;13923.651908702364;14084.169058022391;5484.890302194013;6743.932560674527;11153.776924461628;11713.590024349107;12169.513219471477;11635.360055197045;11668.649940501798;11775.941120294343;11904.761904761683;12032.639020829389;11901.702457438634;12063.698407539881;12149.878501215228;12198.963088137607;12261.877381226073;8282.627281772215;8319.667213311399;8356.373272004503;8417.747467575982;8634.78413039679;11886.227395219283;11996.98025667793;12138;12159.02727781793;12220.75558488843 15:30:17 INFO - PROCESS | 1663 | |3;mootools.html;1470.7205630930123;1665.3421898350148;1937.6318499485096;2021.555257843274;2034.145658823294;7639.694412223512;8308.335333173347;8957.507337096473;9359.766005849857;9394.107559781818;9055.139761722643;9075.546222688856;9145.496997665143;9170.037146099663;9178.54107294636;2564.7819935305474;2570.190390027145;2595.883185256668;2596.6883973923154;2597.6363309136736;2548.2227920484247;2593.805464590154;2594.688637363519;2599.7790187834057;2601.9219423417326;2559.4497183105627;2573.369524466508;2605.6352110704515;2607.38726399296;2620.6462127612813;2554.6551215585846;2558.2069558436756;2575.2789219018705;2587.7412258774066;2602.2843717977516;2539.263613552068;2557.961630575543;2571.4214301782135;2596.8701564921867;2603.153974958146;9141.131592498701;9231.67689130884;9292.53537323131;9295.53522323881;9320.813583728288;5666.858328541819;5676.403977582377;5826.213461182729;5830.708464576796;5850.824475265749;3718.9256214875822;3776.339140650375;3783.9972407312084;3847.576766555677;3852.1525264442057;1063.6755789484282;1079.5573814736;1085.847981282621;1123.4102096399374;1128.802459569572;12186.51253949841;12308.569200077955;12320.383980801014;12342.938285308515;12468.937655311756;5056.974715126401;5122.897542049138;5181.5854731621375;5183.067047931333;5183.870403239949;10657.040866322068;10679.946600266949;10708.250422470352;10709.357438553712;10727.40999245049;5638.718064096779;5717.142428635655;5753.712314384264;5769.826905192851;5797.507211887037;3910.276598829226;5004.074246264453;5021.221710634857;5140.794368225229;5244;4135.669146468275;4181.770002649822;4185.058361868555;4197.958020419818;4213.157368526307;1225.6874497003207;1277.4123903004536;1351.007009847761;1369.205860600849;1378.1662094432925;1419.0917812599944;1439.1437094928501;1447.7321695486157;1462.5466105507326;1476.9556913292618;7542;8434.746957591282;8580.485170889766;8618.310535157172;8622.051574326819;498.23272160872574;507.57363814396086;507.69791973775546;512.2700152282982;513.3879617999485;5895.35151133375;5973.820785376359;5977.342492325841;6027.879442411215;6066.605670631483;10744.462776861126;11201.047910927662;11243.775124497464;11277.830832537518;11279.379634120201;10813.8104808471;11013.174011949135;11086.057685096695;11249.212555121063;11261;8509.319254459628;8562.272206862486;8578.09929957358;8610;8705.956470217736;8044.2760151586635;8049.436539442183;8254.793630159294;8275.751727448187;8337.166283371856;9738.123568878835;10009.649662262078;10034.147097496794;10062.04410581023;10132.544035518567;10058.597656093674;10336.741581460223;10393.948030260102;10437.634682786065;10504.894951050697;7795.688172473037;7849.1758365370815;7899.486533375312;7928.246816552418;7942.483738556975;7291.541691661583;8621.310295176245;8655.394122411371;8724.520151391735;8725.432846865187;7537.434692397982;7817.882731758915;7823.530588164728;7824.84350313002;7940.404469664682;6401.295857455583;7560.130584982798;7590.544567325978;7658.234176582298;7770.261825126604;8153.470024448392;8159.46963447374;8199.22107399796;8203.753887383387;8237.423380363556;6056.182415373868;7065.293470652894;7115.75094871677;7130.144382674112;7151.356377926011;7455.291747283999;7484.775456736306;7485.588292643957;7487.850242995219;7497.962510187633 15:30:17 INFO - PROCESS | 1663 | |4;prototype.html;290.329339226387;334.24460718775566;337.5729701927063;342.3478273888244;344.9926215450883;5650.773969041238;6957.721691132361;7012.228654847962;7046.5067445278855;7080.327368899959;6866.588004719721;6871.347222013913;6887.207971083327;6917.861642767141;6921.653917304127;4844.2733589961435;4948.331975183358;5060.671056381342;5099.541041306282;5163.225516172585;5081.263216833557;5109.718965456898;5137.178051511759;5145.588352931775;5157.277981082632;5062.974685126587;5082.856357319611;5083.135866902617;5093.592512599002;5104.132297509433;5076.289319495274;5084.084864724348;5086.059079070384;5103.617228707824;5143.922841157386;4366.454193225847;4371.584699453547;4379.058502421963;4388.802503887333;4389.626881715058;6468.062130991027;6660.70026848793;6740.966295168541;6785.084013658142;6791.830204244884;5908.911366329508;5953.910691339634;5971.402859714038;5981.371955944606;5983.491403230731;7471.887921681179;7473.065866766654;7476.476646634737;7486.850262994764;7494.6627401767055;4889.217725163957;4896.804127834882;4898.387701537308;4904.264360345941;4910.189818679949;7083.256258092929;7899.644515996736;7911.525308481452;7916.762497125095;7922.970013898214;4836.830710925101;4922.630802689812;4929.235968424829;4930.235813448921;4943.382077240345;5009.198528235464;5010.223415370623;5019.0965626187635;5023.372078490189;5026.79892804291;5938.257717785277;5941.970290148522;5944.405559444108;5947.732352044169;5951.553633477506;7381.298776616213;7385.372243359375;7394.223606521237;7403.481756277117;7469.738559150513;1624.398972380227;1741.0772290685957;1756.7277072053853;1761.0490335219095;1761.1018380625974;1063.3832377221192;1069.5668254356997;1076.311160857052;1078.0459293525287;1078.1428764132534;6843.726250950006;6843.931560684429;6868;6870.31296870309;6894.758683446155;6340.778072767524;7622.00913881203;7710.537367757953;7731.922680773233;7733.072031356161;6817.761378351734;6856.862862742717;6859.759908403182;6864.38220560152;6880.793576192722;3716.758410703296;4050.311447054008;4059.4316795648633;4083.387491876183;4094.815733292009;8073.959630201812;8128.065272493739;8178.877316840252;8201.195736937983;8203.917960820316;5838.591298609056;6198.690065496708;6546;7188.813845715398;7695.730649427243;6628.270890202074;8159.877601835978;8160.755177344689;8167.714130005303;8194.67221311141;7513;7835.216478352119;7841.647125879235;7844.921550784419;7893.289603935674;7701.653425595974;7714.884276735966;7720.53676779395;7745.806354841174;7771.7565189569395;8152.470089444168;8157.551334676413;8165.387595930448;8176.632051557575;8205.466644668077;4800.879978000578;4808.8797780055775;4810.855674329776;4825.782839772289;4843.806247750051;7468;7809.945657336414;7830.2952734254195;7850.214978502104;7868.527888326718;7501.94972703811;7545.207753185837;7545.660445280086;7553.433492488195;7574.621268936641;7545.170031296443;7551.282628150317;7563.281488258606;7577.052868391451;7604.505707129019;7066.7173313066905;7349.706011759684;7349.971004059543;7351.669174887036;7354.227806080285;7509.962450187714;7525.17223105447;7544.245575442412;7581.166071732216;7590.0891892973195;7289.671964761493;7341.926580734124;7346.449016323691;7362.558246505227;7368.300011498899 15:30:17 INFO - PROCESS | 1663 | |5;yui.html;666.1905784471866;669.564782891121;692.9618870962097;718.37860250883;747.9887801682972;15195.392184312628;15301.158436286014;15446.922765386185;15554.533363999084;17298.913505432454;16351.509454716348;16382.75425868613;16383.262753176106;16387.016778993268;16393.590160246;807.4791759315239;985.2807450561095;1001.8597396364515;1006.5671761142705;1007.4005966449987;967.2938754709066;973.5083782689732;983.0464449483989;986.5363279258772;988.6836212412031;1053.7102296868345;1054.0144964458257;1059.2108878885242;1061.7451811565206;1061.787642471505;1001.7645853224486;1019.2814066083394;1026.1636766035695;1041.3491567770143;1042.483970434632;758.8520238553484;769.2384539306103;771.0516065239786;781.144646611959;787.2127872127872;15626.76559851603;15678.451254206162;15692.293846776922;15789.89470737049;15879.206039697969;12498.625041248777;12623.810642840273;12689.428975696115;12733.172343797623;12813.871861281454;9857.704268871945;10266.178705703525;10377.533011014522;10636.149108071335;10651.946740266327;3454.222799870034;3518.944316704978;3520.700740437066;3563.1448452371246;3564.6078931317534;62882;63255.54038022487;82074;82861;83075;9353.859692104625;9616.278779091455;9665.323427360017;9775.169110625677;9940.652077177409;18004.54988625295;21479.463013424476;22189.77810221877;22463;22483;7359.521631093961;7512.248775122444;7618.466707330434;7640.617969101522;7661.846763064707;3299.785513941586;4028.617281358266;4072.3891416287793;4115.238680844053;4128.6284234418445;2876.453473839964;3664.230511592542;3697.482352470656;3697.9815100924325;3741.0086327123336;670.0418401685539;670.9127813384229;677.3057615943698;685.9485538584626;707.3669066185735;579.7478097027806;591.7130191856946;593.7654626422539;609.1897775957965;628.3810446709987;8055.395845311625;8165.673373065011;8259.587020649064;8463.915360846313;8469.830603388022;525.7318767428638;568.8424057043895;617.1329282358294;621.3879328861068;637.955343125986;3316.701496865294;3820.4842346282894;3830.2148059647707;3870.0905287257474;3925.7644541327613;92539.07460925438;97429;100379;102702;103234;75651.62174189094;80068;80158;80814.59592702116;82063;71388;75969.24030759622;76015.61992190004;76129.61935190289;76334;7640.961795190989;7792.571408572583;7925.722599708983;7990.360771138411;8037.03555573335;38289.80855095707;51106.488935110174;51190.74404627953;51726;53265;64989;67505.98741018987;68525.65737171282;74664;74672.87990680253;9549.474778887228;10266.897331026594;10298.794024119326;10325.173986080945;10449.58201671955;9408.29437792182;10715.303505272132;11038.779224415628;11056.723581910195;11472.541098355972;9843.458609776531;10492.79014419692;10565.9471702641;10671.893281067401;10916.890831091587;9899.604015839286;10018.749531261778;10157;10413.687589372332;10742.140628749838;10296.588136474456;10328.380297182193;10384.896151038392;10639;11230.045446136843;8579.65681372738;8726.607302671267;8868.95565522194;8962.955185224033;9087.227585655293;7391.593462359407;8598.183172598594;8874.689385871463;8950.97063837641;9108.726738197865 15:30:17 INFO - PROCESS | 1663 | __end_tp_report 15:30:17 INFO - PROCESS | 1663 | __start_cc_report 15:30:17 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,356 15:30:17 INFO - PROCESS | 1663 | __end_cc_report 15:30:17 INFO - PROCESS | 1663 | __startTimestamp1459549817974__endTimestamp 15:30:17 INFO - PROCESS | 1663 | 15:30:17 INFO - PROCESS | 1663 | ------- Summary: start ------- 15:30:17 INFO - PROCESS | 1663 | Number of tests: 6 15:30:17 INFO - PROCESS | 1663 | 15:30:17 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5825.21 Median:6150.94 stddev:670.65 (10.9%) stddev-sans-first:633.75 15:30:17 INFO - PROCESS | 1663 | Values: 2953.9 3543.6 3567.5 3599.1 3610.7 3950.0 5851.1 5908.0 5919.8 5923.6 4780.5 5951.8 5951.9 5954.3 5970.9 4270.4 5238.3 5310.2 5340.6 5384.5 5302.6 5395.9 5452.9 5493.4 5515.3 5405.1 5412.3 5418.1 5424.0 5443.5 5387.3 5402.7 5443.9 5464.6 5519.0 5292.8 5393.1 5407.9 5432.5 5462.2 5633.0 5784.4 5835.3 5876.6 5959.8 6150.9 6189.4 6230.5 6244.7 6288.5 6244.9 6306.6 6310.3 6310.5 6314.2 5052.9 5872.8 5953.2 6019.0 6034.2 6343.0 6343.0 6343.5 6345.3 6351.0 6282.1 6291.2 6293.5 6296.2 6305.9 5294.3 6209.1 6269.7 6299.1 6319.4 6258.0 6258.7 6263.0 6267.6 6303.3 6230.8 6259.3 6302.8 6303.1 6304.2 4917.7 4974.5 5004.6 5004.9 5046.5 4492.9 4501.7 4503.5 4521.4 4525.1 5744.0 5896.3 5943.0 5944.4 5949.6 6182.1 6210.8 6241.8 6268.2 6308.5 4646.6 5588.6 5950.6 5957.1 5961.9 5468.1 5502.7 5503.6 5506.2 5523.7 6319.4 6393.5 6423.1 6490.1 6492.1 6290.0 6299.0 6312.0 6317.5 6326.7 6344.2 6436.0 6466.5 6484.4 6492.4 6236.8 6257.2 6295.3 6313.9 6320.2 6255.3 6291.6 6295.4 6298.3 6314.5 5854.8 6120.0 6258.2 6267.2 6267.8 6138.5 6250.2 6277.7 6285.2 6306.5 5608.7 6060.5 6109.8 6188.5 6203.8 6167.6 6174.9 6192.0 6261.0 6267.7 6168.0 6175.7 6195.6 6200.0 6206.1 15:30:17 INFO - PROCESS | 1663 | 15:30:17 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:62668.27 Median:40446.19 stddev:125672.84 (310.7%) stddev-sans-first:125938.85 15:30:17 INFO - PROCESS | 1663 | Values: 555.0 562.6 588.6 668.3 682.4 39247.6 39800.6 39879.6 40036.6 40043.8 34159.8 41844.0 42008.6 42388.0 42490.6 9468.6 9687.0 9696.5 9716.0 9724.4 9565.5 9698.1 9802.3 9802.9 9813.6 9718.5 9719.8 9788.0 9804.8 9809.6 9740.7 9774.0 9813.5 9815.5 9816.4 9606.4 9703.4 9720.9 9732.5 9768.5 34574.3 41138.4 41289.6 41530.0 41533.0 3115.9 3124.4 3223.1 3285.2 3461.8 27500.4 27873.4 28894.4 29036.7 29448.3 2776.1 2821.8 2831.7 2860.3 2881.2 421194.0 422803.0 423712.9 424410.0 429314.0 49604.0 72606.6 72678.2 73107.3 73176.0 42724.5 44119.0 48634.8 48760.3 48982.3 16385.0 16516.3 16808.0 17039.5 17060.7 13473.6 13540.5 13558.8 13572.5 13608.7 13950.2 15780.9 15925.6 15929.2 15997.6 6575.0 6695.0 6732.0 6744.9 6745.6 950.2 966.3 1063.3 1154.8 1220.4 30124.8 30286.8 30417.2 30950.8 30993.5 1181.0 1203.3 1228.9 1250.7 1306.4 14693.9 15698.7 15704.0 15903.5 15999.4 506712.0 508738.0 509889.0 511495.4 512639.0 64426.7 64531.7 64987.4 65260.7 65324.7 1535.7 1538.3 1564.2 1579.1 1582.3 25280.0 30231.7 30271.4 30708.4 30743.5 56817.0 57045.4 57132.7 57227.0 57418.4 474750.0 475459.0 485853.0 488136.0 489397.0 34410.8 34475.8 35696.3 35748.3 36316.6 43507.0 45378.8 47496.0 48449.8 49929.0 39581.8 40354.6 42841.1 43305.8 44482.0 39017.0 39238.4 39609.4 40399.2 40493.2 38850.6 39102.8 39434.2 39921.6 40014.4 32263.4 35055.8 35058.7 35177.8 35262.5 26153.5 26179.5 26314.0 26575.9 33691.0 15:30:17 INFO - PROCESS | 1663 | 15:30:17 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35319.87 Median:25667.12 stddev:109568.29 (426.9%) stddev-sans-first:109844.23 15:30:17 INFO - PROCESS | 1663 | Values: 373.7 377.5 382.7 383.5 383.9 17045.7 20564.0 21706.9 22527.5 22530.3 21058.7 21573.9 21791.1 21805.8 21822.3 4618.3 5817.2 6096.5 6105.2 6106.9 4514.7 6493.6 6499.9 6535.6 6543.4 5435.8 5526.9 6374.6 6434.8 6462.8 5626.0 5666.6 5703.9 5716.0 5730.4 5365.7 5491.5 5592.6 5643.0 5654.8 13605.3 13837.3 13946.9 25656.5 25677.7 1822.5 2133.9 2144.8 2210.5 2248.8 10314.4 10314.9 11832.1 14341.8 14683.0 1744.5 1750.4 1815.9 1837.8 1880.1 87479.6 90224.1 93002.0 93339.0 94150.0 11521.6 11695.5 11849.4 11849.8 11865.9 12697.8 13875.5 14134.7 14187.1 14206.4 8641.5 9072.0 9136.6 9185.1 9219.2 9466.2 9485.0 9509.4 9515.0 9551.6 4512.1 4601.0 4610.4 4622.0 4675.3 1902.1 1930.4 1947.2 1951.1 1976.2 710.2 920.3 953.5 962.2 965.1 18084.5 18473.8 19301.0 19738.0 19777.4 955.3 998.7 999.6 1002.9 1035.4 8754.5 9298.6 10630.7 10643.1 10681.4 655727.0 658510.0 663449.0 672974.0 675544.0 102637.0 108349.5 111589.4 114433.0 116508.0 999.8 1024.4 1025.0 1034.8 1062.7 17461.7 17539.4 17644.4 17849.4 18126.3 41632.2 49850.8 51844.5 52126.2 52411.0 65567.0 71057.6 71434.3 74657.5 75884.0 7186.6 8138.0 8299.8 8311.3 8388.2 12183.5 13722.9 13755.9 13923.7 14084.2 5484.9 6743.9 11153.8 11713.6 12169.5 11635.4 11668.6 11775.9 11904.8 12032.6 11901.7 12063.7 12149.9 12199.0 12261.9 8282.6 8319.7 8356.4 8417.7 8634.8 11886.2 11997.0 12138.0 12159.0 12220.8 15:30:17 INFO - PROCESS | 1663 | 15:30:17 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6291.69 Median:509.98 stddev:3335.15 (654.0%) stddev-sans-first:3324.82 15:30:17 INFO - PROCESS | 1663 | Values: 1470.7 1665.3 1937.6 2021.6 2034.1 7639.7 8308.3 8957.5 9359.8 9394.1 9055.1 9075.5 9145.5 9170.0 9178.5 2564.8 2570.2 2595.9 2596.7 2597.6 2548.2 2593.8 2594.7 2599.8 2601.9 2559.4 2573.4 2605.6 2607.4 2620.6 2554.7 2558.2 2575.3 2587.7 2602.3 2539.3 2558.0 2571.4 2596.9 2603.2 9141.1 9231.7 9292.5 9295.5 9320.8 5666.9 5676.4 5826.2 5830.7 5850.8 3718.9 3776.3 3784.0 3847.6 3852.2 1063.7 1079.6 1085.8 1123.4 1128.8 12186.5 12308.6 12320.4 12342.9 12468.9 5057.0 5122.9 5181.6 5183.1 5183.9 10657.0 10679.9 10708.3 10709.4 10727.4 5638.7 5717.1 5753.7 5769.8 5797.5 3910.3 5004.1 5021.2 5140.8 5244.0 4135.7 4181.8 4185.1 4198.0 4213.2 1225.7 1277.4 1351.0 1369.2 1378.2 1419.1 1439.1 1447.7 1462.5 1477.0 7542.0 8434.7 8580.5 8618.3 8622.1 498.2 507.6 507.7 512.3 513.4 5895.4 5973.8 5977.3 6027.9 6066.6 10744.5 11201.0 11243.8 11277.8 11279.4 10813.8 11013.2 11086.1 11249.2 11261.0 8509.3 8562.3 8578.1 8610.0 8706.0 8044.3 8049.4 8254.8 8275.8 8337.2 9738.1 10009.6 10034.1 10062.0 10132.5 10058.6 10336.7 10393.9 10437.6 10504.9 7795.7 7849.2 7899.5 7928.2 7942.5 7291.5 8621.3 8655.4 8724.5 8725.4 7537.4 7817.9 7823.5 7824.8 7940.4 6401.3 7560.1 7590.5 7658.2 7770.3 8153.5 8159.5 8199.2 8203.8 8237.4 6056.2 7065.3 7115.8 7130.1 7151.4 7455.3 7484.8 7485.6 7487.9 7498.0 15:30:17 INFO - PROCESS | 1663 | 15:30:17 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:6082.70 Median:6862.07 stddev:1954.41 (28.5%) stddev-sans-first:1910.93 15:30:17 INFO - PROCESS | 1663 | Values: 290.3 334.2 337.6 342.3 345.0 5650.8 6957.7 7012.2 7046.5 7080.3 6866.6 6871.3 6887.2 6917.9 6921.7 4844.3 4948.3 5060.7 5099.5 5163.2 5081.3 5109.7 5137.2 5145.6 5157.3 5063.0 5082.9 5083.1 5093.6 5104.1 5076.3 5084.1 5086.1 5103.6 5143.9 4366.5 4371.6 4379.1 4388.8 4389.6 6468.1 6660.7 6741.0 6785.1 6791.8 5908.9 5953.9 5971.4 5981.4 5983.5 7471.9 7473.1 7476.5 7486.9 7494.7 4889.2 4896.8 4898.4 4904.3 4910.2 7083.3 7899.6 7911.5 7916.8 7923.0 4836.8 4922.6 4929.2 4930.2 4943.4 5009.2 5010.2 5019.1 5023.4 5026.8 5938.3 5942.0 5944.4 5947.7 5951.6 7381.3 7385.4 7394.2 7403.5 7469.7 1624.4 1741.1 1756.7 1761.0 1761.1 1063.4 1069.6 1076.3 1078.0 1078.1 6843.7 6843.9 6868.0 6870.3 6894.8 6340.8 7622.0 7710.5 7731.9 7733.1 6817.8 6856.9 6859.8 6864.4 6880.8 3716.8 4050.3 4059.4 4083.4 4094.8 8074.0 8128.1 8178.9 8201.2 8203.9 5838.6 6198.7 6546.0 7188.8 7695.7 6628.3 8159.9 8160.8 8167.7 8194.7 7513.0 7835.2 7841.6 7844.9 7893.3 7701.7 7714.9 7720.5 7745.8 7771.8 8152.5 8157.6 8165.4 8176.6 8205.5 4800.9 4808.9 4810.9 4825.8 4843.8 7468.0 7809.9 7830.3 7850.2 7868.5 7501.9 7545.2 7545.7 7553.4 7574.6 7545.2 7551.3 7563.3 7577.1 7604.5 7066.7 7349.7 7350.0 7351.7 7354.2 7510.0 7525.2 7544.2 7581.2 7590.1 7289.7 7341.9 7346.4 7362.6 7368.3 15:30:17 INFO - PROCESS | 1663 | 15:30:17 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18488.60 Median:26895.37 stddev:26516.40 (98.6%) stddev-sans-first:26557.01 15:30:17 INFO - PROCESS | 1663 | Values: 666.2 669.6 693.0 718.4 748.0 15195.4 15301.2 15446.9 15554.5 17298.9 16351.5 16382.8 16383.3 16387.0 16393.6 807.5 985.3 1001.9 1006.6 1007.4 967.3 973.5 983.0 986.5 988.7 1053.7 1054.0 1059.2 1061.7 1061.8 1001.8 1019.3 1026.2 1041.3 1042.5 758.9 769.2 771.1 781.1 787.2 15626.8 15678.5 15692.3 15789.9 15879.2 12498.6 12623.8 12689.4 12733.2 12813.9 9857.7 10266.2 10377.5 10636.1 10651.9 3454.2 3518.9 3520.7 3563.1 3564.6 62882.0 63255.5 82074.0 82861.0 83075.0 9353.9 9616.3 9665.3 9775.2 9940.7 18004.5 21479.5 22189.8 22463.0 22483.0 7359.5 7512.2 7618.5 7640.6 7661.8 3299.8 4028.6 4072.4 4115.2 4128.6 2876.5 3664.2 3697.5 3698.0 3741.0 670.0 670.9 677.3 685.9 707.4 579.7 591.7 593.8 609.2 628.4 8055.4 8165.7 8259.6 8463.9 8469.8 525.7 568.8 617.1 621.4 638.0 3316.7 3820.5 3830.2 3870.1 3925.8 92539.1 97429.0 100379.0 102702.0 103234.0 75651.6 80068.0 80158.0 80814.6 82063.0 71388.0 75969.2 76015.6 76129.6 76334.0 7641.0 7792.6 7925.7 7990.4 8037.0 38289.8 51106.5 51190.7 51726.0 53265.0 64989.0 67506.0 68525.7 74664.0 74672.9 9549.5 10266.9 10298.8 10325.2 10449.6 9408.3 10715.3 11038.8 11056.7 11472.5 9843.5 10492.8 10565.9 10671.9 10916.9 9899.6 10018.7 10157.0 10413.7 10742.1 10296.6 10328.4 10384.9 10639.0 11230.0 8579.7 8726.6 8869.0 8963.0 9087.2 7391.6 8598.2 8874.7 8951.0 9108.7 15:30:17 INFO - PROCESS | 1663 | -------- Summary: end -------- 15:30:17 INFO - PROCESS | 1663 | 15:30:18 INFO - TEST-INFO | 1663: exit 0 15:30:18 INFO - TEST-OK | dromaeo_css | took 1110545ms 15:30:18 INFO - TEST-START | kraken 15:30:18 INFO - operating with platform_type : mac_ 15:30:18 INFO - Initialising browser for kraken test... 15:30:18 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpU9ig62/profile http://localhost:49283/getInfo.html) 15:30:21 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 15:30:21 INFO - PROCESS | 1676 | colorDepth:24 15:30:21 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 15:30:21 INFO - PROCESS | 1676 | __metrics 15:30:21 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:30:21 INFO - TEST-INFO | 1676: exit 0 15:30:21 INFO - Browser initialized. 15:30:21 INFO - Running cycle 1/1 for kraken test... 15:30:21 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpU9ig62/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:30:33 INFO - PROCESS | 1679 | RSS: Main: 219598848 15:30:33 INFO - PROCESS | 1679 | 15:30:36 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 15:30:36 INFO - PROCESS | 1679 | RSS: Main: 233828352 15:30:36 INFO - PROCESS | 1679 | 15:30:39 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 15:30:40 INFO - PROCESS | 1679 | RSS: Main: 241909760 15:30:40 INFO - PROCESS | 1679 | 15:30:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 15:30:44 INFO - PROCESS | 1679 | RSS: Main: 245182464 15:30:44 INFO - PROCESS | 1679 | 15:30:45 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 15:30:46 INFO - PROCESS | 1679 | RSS: Main: 245518336 15:30:46 INFO - PROCESS | 1679 | 15:30:48 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:30:49 INFO - PROCESS | 1679 | RSS: Main: 247091200 15:30:49 INFO - PROCESS | 1679 | 15:30:52 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 15:30:52 INFO - PROCESS | 1679 | RSS: Main: 248221696 15:30:52 INFO - PROCESS | 1679 | 15:30:55 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 15:30:56 INFO - PROCESS | 1679 | RSS: Main: 248078336 15:30:56 INFO - PROCESS | 1679 | 15:30:59 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 15:30:59 INFO - PROCESS | 1679 | RSS: Main: 248172544 15:30:59 INFO - PROCESS | 1679 | 15:31:01 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:31:01 INFO - PROCESS | 1679 | RSS: Main: 246239232 15:31:01 INFO - PROCESS | 1679 | 15:31:03 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:31:04 INFO - PROCESS | 1679 | RSS: Main: 246255616 15:31:04 INFO - PROCESS | 1679 | 15:31:06 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:31:07 INFO - PROCESS | 1679 | RSS: Main: 247267328 15:31:07 INFO - PROCESS | 1679 | 15:31:09 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:31:10 INFO - PROCESS | 1679 | RSS: Main: 246644736 15:31:10 INFO - PROCESS | 1679 | 15:31:12 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:31:13 INFO - PROCESS | 1679 | RSS: Main: 248844288 15:31:13 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 15:31:15 INFO - PROCESS | 1679 | RSS: Main: 249225216 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | __start_tp_report 15:31:15 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 15:31:15 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 15:31:15 INFO - PROCESS | 1679 | |i|pagename|runs| 15:31:15 INFO - PROCESS | 1679 | |0;ai-astar;117;111;110;168;168;130;114;115;116;113 15:31:15 INFO - PROCESS | 1679 | |1;audio-beat-detection;146;118;150;146;125;154;152;183;145;120 15:31:15 INFO - PROCESS | 1679 | |2;audio-dft;192;193;195;199;227;264;199;197;196;206 15:31:15 INFO - PROCESS | 1679 | |3;audio-fft;87;80;77;114;56;56;58;59;130;54 15:31:15 INFO - PROCESS | 1679 | |4;audio-oscillator;83;85;127;118;119;122;120;82;79;117 15:31:15 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;79;131;130;85;89;85;87;101;135;85 15:31:15 INFO - PROCESS | 1679 | |6;imaging-darkroom;94;94;93;95;95;94;98;92;150;102 15:31:15 INFO - PROCESS | 1679 | |7;imaging-desaturate;95;83;144;98;151;139;100;96;95;95 15:31:15 INFO - PROCESS | 1679 | |8;json-parse-financial;55;58;58;59;59;59;58;66;58;55 15:31:15 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;64;65;69;74;73;67;70;86;100;96 15:31:15 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;83;80;81;83;81;81;82;81;82;85 15:31:15 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;130;119;123;131;133;121;134;139;140;119 15:31:15 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;125;123;164;184;179;135;136;130;139;174 15:31:15 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;67;66;65;68;65;69;66;59;60;80 15:31:15 INFO - PROCESS | 1679 | __end_tp_report 15:31:15 INFO - PROCESS | 1679 | __start_cc_report 15:31:15 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,917 15:31:15 INFO - PROCESS | 1679 | __end_cc_report 15:31:15 INFO - PROCESS | 1679 | __startTimestamp1459549875392__endTimestamp 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | ------- Summary: start ------- 15:31:15 INFO - PROCESS | 1679 | Number of tests: 14 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:126.20 Median:116.50 stddev:22.70 (19.5%) stddev-sans-first:23.84 15:31:15 INFO - PROCESS | 1679 | Values: 117.0 111.0 110.0 168.0 168.0 130.0 114.0 115.0 116.0 113.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:148.00 stddev:19.27 (13.0%) stddev-sans-first:20.43 15:31:15 INFO - PROCESS | 1679 | Values: 146.0 118.0 150.0 146.0 125.0 154.0 152.0 183.0 145.0 120.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:206.80 Median:199.00 stddev:22.52 (11.3%) stddev-sans-first:23.24 15:31:15 INFO - PROCESS | 1679 | Values: 192.0 193.0 195.0 199.0 227.0 264.0 199.0 197.0 196.0 206.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:77.10 Median:58.50 stddev:26.63 (45.5%) stddev-sans-first:28.00 15:31:15 INFO - PROCESS | 1679 | Values: 87.0 80.0 77.0 114.0 56.0 56.0 58.0 59.0 130.0 54.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:103.00 stddev:19.99 (19.4%) stddev-sans-first:19.52 15:31:15 INFO - PROCESS | 1679 | Values: 83.0 85.0 127.0 118.0 119.0 122.0 120.0 82.0 79.0 117.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:100.70 Median:85.00 stddev:22.33 (26.3%) stddev-sans-first:22.26 15:31:15 INFO - PROCESS | 1679 | Values: 79.0 131.0 130.0 85.0 89.0 85.0 87.0 101.0 135.0 85.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:100.70 Median:94.00 stddev:17.56 (18.7%) stddev-sans-first:18.45 15:31:15 INFO - PROCESS | 1679 | Values: 94.0 94.0 93.0 95.0 95.0 94.0 98.0 92.0 150.0 102.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:109.60 Median:95.00 stddev:24.77 (26.1%) stddev-sans-first:25.70 15:31:15 INFO - PROCESS | 1679 | Values: 95.0 83.0 144.0 98.0 151.0 139.0 100.0 96.0 95.0 95.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.50 stddev:3.03 (5.2%) stddev-sans-first:2.93 15:31:15 INFO - PROCESS | 1679 | Values: 55.0 58.0 58.0 59.0 59.0 59.0 58.0 66.0 58.0 55.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:76.40 Median:71.50 stddev:12.99 (18.2%) stddev-sans-first:12.98 15:31:15 INFO - PROCESS | 1679 | Values: 64.0 65.0 69.0 74.0 73.0 67.0 70.0 86.0 100.0 96.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:1.45 (1.8%) stddev-sans-first:1.48 15:31:15 INFO - PROCESS | 1679 | Values: 83.0 80.0 81.0 83.0 81.0 81.0 82.0 81.0 82.0 85.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:132.00 stddev:7.94 (6.0%) stddev-sans-first:8.41 15:31:15 INFO - PROCESS | 1679 | Values: 130.0 119.0 123.0 131.0 133.0 121.0 134.0 139.0 140.0 119.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:151.50 stddev:23.69 (15.6%) stddev-sans-first:23.50 15:31:15 INFO - PROCESS | 1679 | Values: 125.0 123.0 164.0 184.0 179.0 135.0 136.0 130.0 139.0 174.0 15:31:15 INFO - PROCESS | 1679 | 15:31:15 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:5.72 (8.6%) stddev-sans-first:6.06 15:31:15 INFO - PROCESS | 1679 | Values: 67.0 66.0 65.0 68.0 65.0 69.0 66.0 59.0 60.0 80.0 15:31:15 INFO - PROCESS | 1679 | -------- Summary: end -------- 15:31:15 INFO - PROCESS | 1679 | 15:31:16 INFO - TEST-INFO | 1679: exit 0 15:31:16 INFO - TEST-OK | kraken | took 57684ms 15:31:16 INFO - SUITE-END | took 1168s 15:31:16 INFO - Completed test suite (00:19:28) 15:31:16 INFO - javascript benchmark 15:31:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2953.8523073846304, 3543.6102028776836, 3567.464880267958, 3599.1362073102464, 3610.729195310351, 3950.032242100686, 5851.122331650249, 5908.0, 5919.763209471626, 5923.61496502727, 4780.450248221456, 5951.791687290945, 5951.9107213391835, 5954.31525374581, 5970.8805823883495, 4270.3807947847545, 5238.292830467876, 5310.15037593985, 5340.599455040868, 5384.488473595022, 5302.6023048271345, 5395.892082158354, 5452.91820622691, 5493.423190564973, 5515.255440515519, 5405.081136206854, 5412.323459567554, 5418.078926582471, 5423.9694458052845, 5443.482869127446, 5387.326584176978, 5402.6758394496455, 5443.918341224885, 5464.562834973212, 5518.972405137949, 5292.823551028723, 5393.1370980643305, 5407.864803379907, 5432.511074003359, 5462.153366228241, 5633.0, 5784.392638772911, 5835.270591176103, 5876.588638795286, 5959.791407300767, 6150.938490615082, 6189.38106189382, 6230.470410015154, 6244.718987645567, 6288.496920246369, 6244.937550624481, 6306.590071645328, 6310.33741457145, 6310.495160387158, 6314.179156709644, 5052.898942021176, 5872.823815285506, 5953.226080609493, 6018.96990515049, 6034.155218269446, 6342.953412686855, 6343.0, 6343.492520598341, 6345.270293916166, 6350.968245158745, 6282.057691346335, 6291.182146321041, 6293.496520278367, 6296.212973378328, 6305.873882522415, 5294.311739473844, 6209.06863970399, 6269.7178626961895, 6299.118123462719, 6319.368063193736, 6258.0, 6258.687065646699, 6262.968685156545, 6267.592606480564, 6303.338149494329, 6230.7507699691505, 6259.342769009279, 6302.810915672537, 6303.117563541108, 6304.211973503312, 4917.704937703749, 4974.527419895104, 5004.574611158019, 5004.9499505005215, 5046.545810877039, 4492.865214043584, 4501.68488205829, 4503.549645035536, 4521.434820647419, 4525.072360166158, 5744.023516002289, 5896.262967129109, 5943.049112142036, 5944.405559444108, 5949.6430214187285, 6182.072689096672, 6210.7515699372425, 6241.843953901189, 6268.247810262797, 6308.495320374359, 4646.581807637329, 5588.580856435784, 5950.613210141327, 5957.106434034843, 5961.910571341434, 5468.125099983983, 5502.669839809624, 5503.6147469677535, 5506.201600767866, 5523.6685798852195, 6319.399657032666, 6393.456556192683, 6423.13287706163, 6490.091387205889, 6492.091107245084, 6290.025046117859, 6299.023651334051, 6311.96844015777, 6317.463015643538, 6326.6520341381665, 6344.206974128234, 6436.034594810816, 6466.547341686037, 6484.448821850006, 6492.383223593751, 6236.781712640217, 6257.186565746424, 6295.276043255084, 6313.936860631518, 6320.178376810985, 6255.280642726145, 6291.591046581958, 6295.3704629538515, 6298.275698294755, 6314.494840412848, 5854.824355269348, 6119.959572021022, 6258.249010118633, 6267.185265915402, 6267.780627678009, 6138.51101655979, 6250.1874756281395, 6277.71750271248, 6285.182926219562, 6306.527010474325, 5608.653923058355, 6060.484878780305, 6109.847253818512, 6188.535859810442, 6203.782867599793, 6167.629942203482, 6174.938250617436, 6191.9690401547705, 6261.0, 6267.717952692231, 6168.0439531872635, 6175.722092505938, 6195.628262304276, 6199.969000154971, 6206.131141640264], "unit": "score", "name": "dojo.html", "value": 5784.99366424597}, {"lowerIsBetter": false, "replicates": [554.9972250138749, 562.6427218716117, 588.6085752974273, 668.2825139391764, 682.3756263019337, 39247.60752392475, 39800.60199398005, 39879.60120398795, 40036.59871904487, 40043.79978100109, 34159.80440684577, 41843.95390115248, 42008.57991420085, 42388.0, 42490.57509424905, 9468.621255149803, 9687.0, 9696.46669433181, 9716.0, 9724.367916085466, 9565.473898935556, 9698.078682525149, 9802.313838031305, 9802.852957205647, 9813.558389872438, 9718.465484398355, 9719.757006074835, 9788.021197880225, 9804.754881127958, 9809.558569864374, 9740.659076932308, 9774.0, 9813.460259685715, 9815.460149691764, 9816.361936474106, 9606.423614583078, 9703.369280996712, 9720.854187187198, 9732.513374331254, 9768.51157442125, 34574.308513829834, 41138.38292425616, 41289.58710412888, 41529.961750956165, 41533.0, 3115.937681246385, 3124.390743804959, 3223.0814217948005, 3285.162283617662, 3461.809600471973, 27500.449991000267, 27873.442531149263, 28894.42211155765, 29036.70963290361, 29448.263793405335, 2776.0561409120996, 2821.7883658725473, 2831.674357448899, 2860.3278229616026, 2881.1644623059287, 421194.0, 422803.0, 423712.88143559394, 424410.0, 429314.0, 49604.0079198414, 72606.63696681483, 72678.18304542323, 73107.26892731004, 73176.0, 42724.50464233799, 44119.0, 48634.75682621635, 48760.26859597109, 48982.26526602104, 16385.01689898586, 16516.339346426248, 16808.0, 17039.48881533556, 17060.658786824195, 13473.595792126252, 13540.526081587097, 13558.796618050737, 13572.457101715821, 13608.727825443633, 13950.232737199349, 15780.92109539445, 15925.601859953362, 15929.203539822962, 15997.600059998593, 6574.967125164344, 6694.966525167343, 6731.966340168366, 6744.932550674529, 6745.5952642841585, 950.2018304624149, 966.3042609321277, 1063.330102035728, 1154.8383226348317, 1220.4446976625613, 30124.84937575342, 30286.788528459056, 30417.239569010508, 30950.84524577408, 30993.535096973563, 1180.976380472403, 1203.272020427646, 1228.8586812516676, 1250.7123361626877, 1306.405585458614, 14693.853061469463, 15698.68602627941, 15703.979241349276, 15903.52289431319, 15999.360025598846, 506712.0, 508738.0, 509889.0, 511495.442522785, 512639.0, 64426.6778666113, 64531.74138905116, 64987.35012649813, 65260.67369663122, 65324.673376633764, 1535.6698309863432, 1538.30007346657, 1564.1631727025986, 1579.0762403993792, 1582.327510807902, 25280.0, 30231.69768302377, 30271.394572108875, 30708.385832282784, 30743.538846917763, 56817.0, 57045.42954570567, 57132.71433642805, 57227.0, 57418.42581574298, 474750.0, 475459.0, 485853.0, 488136.0, 489397.0, 34410.827945861114, 34475.82762086173, 35696.28607427889, 35748.28503429865, 36316.636833631324, 43507.0, 45378.77310613426, 47496.0, 48449.757751212426, 49929.0, 39581.80209098936, 40354.596454036255, 42841.1431771369, 43305.783471082446, 44482.0, 39017.0, 39238.41142382924, 39609.40585891157, 40399.19201615892, 40493.19013619652, 38850.6114938847, 39102.82691519259, 39434.2113157741, 39921.60078399179, 40014.39978400268, 32263.35473290474, 35055.82472087623, 35058.721183123016, 35177.82411087928, 35262.47106293459, 26153.476930460904, 26179.476410471303, 26314.0, 26575.867120664272, 33690.98927032193], "unit": "score", "name": "ext.html", "value": 20088.28632272344}, {"lowerIsBetter": false, "replicates": [373.7029061895791, 377.5035827886329, 382.6785500179849, 383.5244297071632, 383.8829157107083, 17045.659086818272, 20564.0, 21706.89146554269, 22527.54944901101, 22530.324090277318, 21058.684119738176, 21573.892130539327, 21791.128354865785, 21805.781942180613, 21822.345329640135, 4618.284165954283, 5817.185594016841, 6096.51227901769, 6105.20632317798, 6106.908396374058, 4514.729116253019, 6493.6103833769885, 6499.9350006500035, 6535.60786352818, 6543.411093001629, 5435.809746658868, 5526.944730552704, 6374.617522948614, 6434.839129021765, 6462.838429039265, 5625.971870140644, 5666.631668941526, 5703.914441283343, 5716.028275193227, 5730.4269573042775, 5365.704886231256, 5491.533219676332, 5592.6085174037835, 5643.0, 5654.830355089354, 13605.251711155883, 13837.30813459323, 13946.86053139476, 25656.486870262677, 25677.743222567722, 1822.527636689562, 2133.871967681944, 2144.785521447858, 2210.502636906683, 2248.8313376496662, 10314.38113713172, 10314.9484252579, 11832.053435725122, 14341.78487322691, 14683.045602035834, 1744.476657002894, 1750.4136114401563, 1815.8819676721102, 1837.8345948864533, 1880.0693656639914, 87479.56260218722, 90224.09775902223, 93002.0, 93339.0, 94150.0, 11521.596744114084, 11695.473703683354, 11849.401984392669, 11849.763004739856, 11865.881341186478, 12697.793709597574, 13875.514356997457, 14134.717305654034, 14187.077839940372, 14206.431742730381, 8641.524716140548, 9072.0, 9136.634534618674, 9185.081491850762, 9219.21636660878, 9466.242700583936, 9484.952575237217, 9509.429434233829, 9514.952425237829, 9551.570179341947, 4512.120136573402, 4600.97699511507, 4610.354550362952, 4622.0, 4675.322078298627, 1902.1060101752155, 1930.4401723500027, 1947.2113793913488, 1951.1414977409895, 1976.2193933396227, 710.1620088295861, 920.2637889688223, 953.5422996961497, 962.1965658674944, 965.1458459263603, 18084.547886302684, 18473.815261847478, 19301.03494825253, 19738.0, 19777.40667779969, 955.302629080775, 998.7103739915489, 999.6001599360314, 1002.8646132771983, 1035.420164707751, 8754.51850148248, 9298.628054877729, 10630.681079567625, 10643.148548116287, 10681.359118452918, 655727.0, 658510.0, 663449.0, 672974.0, 675544.0, 102637.0, 108349.45825270824, 111589.44205279084, 114433.0, 116508.0, 999.7500624843789, 1024.4007255755466, 1024.9795004099876, 1034.8085604163255, 1062.7130674717628, 17461.650766984843, 17539.386121485688, 17644.382446614305, 17849.37527186542, 18126.274949002418, 41632.16735665209, 49850.750746246034, 51844.481555183964, 52126.21810672767, 52410.95178096493, 65567.01649475166, 71057.64471177818, 71434.28565714277, 74657.50684986162, 75884.0, 7186.568805871664, 8138.0, 8299.834003319778, 8311.293540049164, 8388.163646627978, 12183.512659493521, 13722.931385343009, 13755.862441375859, 13923.651908702364, 14084.169058022391, 5484.890302194013, 6743.932560674527, 11153.776924461628, 11713.590024349107, 12169.513219471477, 11635.360055197045, 11668.649940501798, 11775.941120294343, 11904.761904761683, 12032.639020829389, 11901.702457438634, 12063.698407539881, 12149.878501215228, 12198.963088137607, 12261.877381226073, 8282.627281772215, 8319.667213311399, 8356.373272004503, 8417.747467575982, 8634.78413039679, 11886.227395219283, 11996.98025667793, 12138.0, 12159.02727781793, 12220.75558488843], "unit": "score", "name": "jquery.html", "value": 9471.981891215959}, {"lowerIsBetter": false, "replicates": [1470.7205630930123, 1665.3421898350148, 1937.6318499485096, 2021.555257843274, 2034.145658823294, 7639.694412223512, 8308.335333173347, 8957.507337096473, 9359.766005849857, 9394.107559781818, 9055.139761722643, 9075.546222688856, 9145.496997665143, 9170.037146099663, 9178.54107294636, 2564.7819935305474, 2570.190390027145, 2595.883185256668, 2596.6883973923154, 2597.6363309136736, 2548.2227920484247, 2593.805464590154, 2594.688637363519, 2599.7790187834057, 2601.9219423417326, 2559.4497183105627, 2573.369524466508, 2605.6352110704515, 2607.38726399296, 2620.6462127612813, 2554.6551215585846, 2558.2069558436756, 2575.2789219018705, 2587.7412258774066, 2602.2843717977516, 2539.263613552068, 2557.961630575543, 2571.4214301782135, 2596.8701564921867, 2603.153974958146, 9141.131592498701, 9231.67689130884, 9292.53537323131, 9295.53522323881, 9320.813583728288, 5666.858328541819, 5676.403977582377, 5826.213461182729, 5830.708464576796, 5850.824475265749, 3718.9256214875822, 3776.339140650375, 3783.9972407312084, 3847.576766555677, 3852.1525264442057, 1063.6755789484282, 1079.5573814736, 1085.847981282621, 1123.4102096399374, 1128.802459569572, 12186.51253949841, 12308.569200077955, 12320.383980801014, 12342.938285308515, 12468.937655311756, 5056.974715126401, 5122.897542049138, 5181.5854731621375, 5183.067047931333, 5183.870403239949, 10657.040866322068, 10679.946600266949, 10708.250422470352, 10709.357438553712, 10727.40999245049, 5638.718064096779, 5717.142428635655, 5753.712314384264, 5769.826905192851, 5797.507211887037, 3910.276598829226, 5004.074246264453, 5021.221710634857, 5140.794368225229, 5244.0, 4135.669146468275, 4181.770002649822, 4185.058361868555, 4197.958020419818, 4213.157368526307, 1225.6874497003207, 1277.4123903004536, 1351.007009847761, 1369.205860600849, 1378.1662094432925, 1419.0917812599944, 1439.1437094928501, 1447.7321695486157, 1462.5466105507326, 1476.9556913292618, 7542.0, 8434.746957591282, 8580.485170889766, 8618.310535157172, 8622.051574326819, 498.23272160872574, 507.57363814396086, 507.69791973775546, 512.2700152282982, 513.3879617999485, 5895.35151133375, 5973.820785376359, 5977.342492325841, 6027.879442411215, 6066.605670631483, 10744.462776861126, 11201.047910927662, 11243.775124497464, 11277.830832537518, 11279.379634120201, 10813.8104808471, 11013.174011949135, 11086.057685096695, 11249.212555121063, 11261.0, 8509.319254459628, 8562.272206862486, 8578.09929957358, 8610.0, 8705.956470217736, 8044.2760151586635, 8049.436539442183, 8254.793630159294, 8275.751727448187, 8337.166283371856, 9738.123568878835, 10009.649662262078, 10034.147097496794, 10062.04410581023, 10132.544035518567, 10058.597656093674, 10336.741581460223, 10393.948030260102, 10437.634682786065, 10504.894951050697, 7795.688172473037, 7849.1758365370815, 7899.486533375312, 7928.246816552418, 7942.483738556975, 7291.541691661583, 8621.310295176245, 8655.394122411371, 8724.520151391735, 8725.432846865187, 7537.434692397982, 7817.882731758915, 7823.530588164728, 7824.84350313002, 7940.404469664682, 6401.295857455583, 7560.130584982798, 7590.544567325978, 7658.234176582298, 7770.261825126604, 8153.470024448392, 8159.46963447374, 8199.22107399796, 8203.753887383387, 8237.423380363556, 6056.182415373868, 7065.293470652894, 7115.75094871677, 7130.144382674112, 7151.356377926011, 7455.291747283999, 7484.775456736306, 7485.588292643957, 7487.850242995219, 7497.962510187633], "unit": "score", "name": "mootools.html", "value": 5050.293875337373}, {"lowerIsBetter": false, "replicates": [290.329339226387, 334.24460718775566, 337.5729701927063, 342.3478273888244, 344.9926215450883, 5650.773969041238, 6957.721691132361, 7012.228654847962, 7046.5067445278855, 7080.327368899959, 6866.588004719721, 6871.347222013913, 6887.207971083327, 6917.861642767141, 6921.653917304127, 4844.2733589961435, 4948.331975183358, 5060.671056381342, 5099.541041306282, 5163.225516172585, 5081.263216833557, 5109.718965456898, 5137.178051511759, 5145.588352931775, 5157.277981082632, 5062.974685126587, 5082.856357319611, 5083.135866902617, 5093.592512599002, 5104.132297509433, 5076.289319495274, 5084.084864724348, 5086.059079070384, 5103.617228707824, 5143.922841157386, 4366.454193225847, 4371.584699453547, 4379.058502421963, 4388.802503887333, 4389.626881715058, 6468.062130991027, 6660.70026848793, 6740.966295168541, 6785.084013658142, 6791.830204244884, 5908.911366329508, 5953.910691339634, 5971.402859714038, 5981.371955944606, 5983.491403230731, 7471.887921681179, 7473.065866766654, 7476.476646634737, 7486.850262994764, 7494.6627401767055, 4889.217725163957, 4896.804127834882, 4898.387701537308, 4904.264360345941, 4910.189818679949, 7083.256258092929, 7899.644515996736, 7911.525308481452, 7916.762497125095, 7922.970013898214, 4836.830710925101, 4922.630802689812, 4929.235968424829, 4930.235813448921, 4943.382077240345, 5009.198528235464, 5010.223415370623, 5019.0965626187635, 5023.372078490189, 5026.79892804291, 5938.257717785277, 5941.970290148522, 5944.405559444108, 5947.732352044169, 5951.553633477506, 7381.298776616213, 7385.372243359375, 7394.223606521237, 7403.481756277117, 7469.738559150513, 1624.398972380227, 1741.0772290685957, 1756.7277072053853, 1761.0490335219095, 1761.1018380625974, 1063.3832377221192, 1069.5668254356997, 1076.311160857052, 1078.0459293525287, 1078.1428764132534, 6843.726250950006, 6843.931560684429, 6868.0, 6870.31296870309, 6894.758683446155, 6340.778072767524, 7622.00913881203, 7710.537367757953, 7731.922680773233, 7733.072031356161, 6817.761378351734, 6856.862862742717, 6859.759908403182, 6864.38220560152, 6880.793576192722, 3716.758410703296, 4050.311447054008, 4059.4316795648633, 4083.387491876183, 4094.815733292009, 8073.959630201812, 8128.065272493739, 8178.877316840252, 8201.195736937983, 8203.917960820316, 5838.591298609056, 6198.690065496708, 6546.0, 7188.813845715398, 7695.730649427243, 6628.270890202074, 8159.877601835978, 8160.755177344689, 8167.714130005303, 8194.67221311141, 7513.0, 7835.216478352119, 7841.647125879235, 7844.921550784419, 7893.289603935674, 7701.653425595974, 7714.884276735966, 7720.53676779395, 7745.806354841174, 7771.7565189569395, 8152.470089444168, 8157.551334676413, 8165.387595930448, 8176.632051557575, 8205.466644668077, 4800.879978000578, 4808.8797780055775, 4810.855674329776, 4825.782839772289, 4843.806247750051, 7468.0, 7809.945657336414, 7830.2952734254195, 7850.214978502104, 7868.527888326718, 7501.94972703811, 7545.207753185837, 7545.660445280086, 7553.433492488195, 7574.621268936641, 7545.170031296443, 7551.282628150317, 7563.281488258606, 7577.052868391451, 7604.505707129019, 7066.7173313066905, 7349.706011759684, 7349.971004059543, 7351.669174887036, 7354.227806080285, 7509.962450187714, 7525.17223105447, 7544.245575442412, 7581.166071732216, 7590.0891892973195, 7289.671964761493, 7341.926580734124, 7346.449016323691, 7362.558246505227, 7368.300011498899], "unit": "score", "name": "prototype.html", "value": 5417.870063004337}, {"lowerIsBetter": false, "replicates": [666.1905784471866, 669.564782891121, 692.9618870962097, 718.37860250883, 747.9887801682972, 15195.392184312628, 15301.158436286014, 15446.922765386185, 15554.533363999084, 17298.913505432454, 16351.509454716348, 16382.75425868613, 16383.262753176106, 16387.016778993268, 16393.590160246, 807.4791759315239, 985.2807450561095, 1001.8597396364515, 1006.5671761142705, 1007.4005966449987, 967.2938754709066, 973.5083782689732, 983.0464449483989, 986.5363279258772, 988.6836212412031, 1053.7102296868345, 1054.0144964458257, 1059.2108878885242, 1061.7451811565206, 1061.787642471505, 1001.7645853224486, 1019.2814066083394, 1026.1636766035695, 1041.3491567770143, 1042.483970434632, 758.8520238553484, 769.2384539306103, 771.0516065239786, 781.144646611959, 787.2127872127872, 15626.76559851603, 15678.451254206162, 15692.293846776922, 15789.89470737049, 15879.206039697969, 12498.625041248777, 12623.810642840273, 12689.428975696115, 12733.172343797623, 12813.871861281454, 9857.704268871945, 10266.178705703525, 10377.533011014522, 10636.149108071335, 10651.946740266327, 3454.222799870034, 3518.944316704978, 3520.700740437066, 3563.1448452371246, 3564.6078931317534, 62882.0, 63255.54038022487, 82074.0, 82861.0, 83075.0, 9353.859692104625, 9616.278779091455, 9665.323427360017, 9775.169110625677, 9940.652077177409, 18004.54988625295, 21479.463013424476, 22189.77810221877, 22463.0, 22483.0, 7359.521631093961, 7512.248775122444, 7618.466707330434, 7640.617969101522, 7661.846763064707, 3299.785513941586, 4028.617281358266, 4072.3891416287793, 4115.238680844053, 4128.6284234418445, 2876.453473839964, 3664.230511592542, 3697.482352470656, 3697.9815100924325, 3741.0086327123336, 670.0418401685539, 670.9127813384229, 677.3057615943698, 685.9485538584626, 707.3669066185735, 579.7478097027806, 591.7130191856946, 593.7654626422539, 609.1897775957965, 628.3810446709987, 8055.395845311625, 8165.673373065011, 8259.587020649064, 8463.915360846313, 8469.830603388022, 525.7318767428638, 568.8424057043895, 617.1329282358294, 621.3879328861068, 637.955343125986, 3316.701496865294, 3820.4842346282894, 3830.2148059647707, 3870.0905287257474, 3925.7644541327613, 92539.07460925438, 97429.0, 100379.0, 102702.0, 103234.0, 75651.62174189094, 80068.0, 80158.0, 80814.59592702116, 82063.0, 71388.0, 75969.24030759622, 76015.61992190004, 76129.61935190289, 76334.0, 7640.961795190989, 7792.571408572583, 7925.722599708983, 7990.360771138411, 8037.03555573335, 38289.80855095707, 51106.488935110174, 51190.74404627953, 51726.0, 53265.0, 64989.0, 67505.98741018987, 68525.65737171282, 74664.0, 74672.87990680253, 9549.474778887228, 10266.897331026594, 10298.794024119326, 10325.173986080945, 10449.58201671955, 9408.29437792182, 10715.303505272132, 11038.779224415628, 11056.723581910195, 11472.541098355972, 9843.458609776531, 10492.79014419692, 10565.9471702641, 10671.893281067401, 10916.890831091587, 9899.604015839286, 10018.749531261778, 10157.0, 10413.687589372332, 10742.140628749838, 10296.588136474456, 10328.380297182193, 10384.896151038392, 10639.0, 11230.045446136843, 8579.65681372738, 8726.607302671267, 8868.95565522194, 8962.955185224033, 9087.227585655293, 7391.593462359407, 8598.183172598594, 8874.689385871463, 8950.97063837641, 9108.726738197865], "unit": "score", "name": "yui.html", "value": 6941.3229410843815}], "name": "dromaeo_css", "value": 7704.028080000828}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 111.0, 110.0, 168.0, 168.0, 130.0, 114.0, 115.0, 116.0, 113.0], "unit": "score", "name": "ai-astar", "value": 126.2}, {"lowerIsBetter": true, "replicates": [146.0, 118.0, 150.0, 146.0, 125.0, 154.0, 152.0, 183.0, 145.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 143.9}, {"lowerIsBetter": true, "replicates": [192.0, 193.0, 195.0, 199.0, 227.0, 264.0, 199.0, 197.0, 196.0, 206.0], "unit": "score", "name": "audio-dft", "value": 206.8}, {"lowerIsBetter": true, "replicates": [87.0, 80.0, 77.0, 114.0, 56.0, 56.0, 58.0, 59.0, 130.0, 54.0], "unit": "score", "name": "audio-fft", "value": 77.1}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 127.0, 118.0, 119.0, 122.0, 120.0, 82.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [79.0, 131.0, 130.0, 85.0, 89.0, 85.0, 87.0, 101.0, 135.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 93.0, 95.0, 95.0, 94.0, 98.0, 92.0, 150.0, 102.0], "unit": "score", "name": "imaging-darkroom", "value": 100.7}, {"lowerIsBetter": true, "replicates": [95.0, 83.0, 144.0, 98.0, 151.0, 139.0, 100.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 109.6}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 58.0, 59.0, 59.0, 59.0, 58.0, 66.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 69.0, 74.0, 73.0, 67.0, 70.0, 86.0, 100.0, 96.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.4}, {"lowerIsBetter": true, "replicates": [83.0, 80.0, 81.0, 83.0, 81.0, 81.0, 82.0, 81.0, 82.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [130.0, 119.0, 123.0, 131.0, 133.0, 121.0, 134.0, 139.0, 140.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.9}, {"lowerIsBetter": true, "replicates": [125.0, 123.0, 164.0, 184.0, 179.0, 135.0, 136.0, 130.0, 139.0, 174.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 65.0, 68.0, 65.0, 69.0, 66.0, 59.0, 60.0, 80.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1531.3000000000006}]} 15:31:16 INFO - Return code: 0 15:31:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:31:16 ERROR - # TBPL SUCCESS # 15:31:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:31:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:31:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:31:16 INFO - 2016-04-01 15:31:16.706 screenresolution[1684:10376] starting screenresolution argv=screenresolution get 15:31:16 INFO - 2016-04-01 15:31:16.708 screenresolution[1684:10376] Display 0: 1600x1200x32@60 15:31:16 INFO - 2016-04-01 15:31:16.714 screenresolution[1685:10379] starting screenresolution argv=screenresolution list 15:31:16 INFO - Available Modes on Display 0 15:31:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:31:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:31:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:31:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:31:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:31:16 INFO - Intel Iris: 15:31:16 INFO - Chipset Model: Intel Iris 15:31:16 INFO - Type: GPU 15:31:16 INFO - Bus: Built-In 15:31:16 INFO - VRAM (Dynamic, Max): 1536 MB 15:31:16 INFO - Vendor: Intel (0x8086) 15:31:16 INFO - Device ID: 0x0a2e 15:31:16 INFO - Revision ID: 0x0009 15:31:16 INFO - Displays: 15:31:16 INFO - Display: 15:31:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:31:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:31:16 INFO - Display Serial Number: 1600x1200 60 15:31:16 INFO - Main Display: Yes 15:31:16 INFO - Mirror: Off 15:31:16 INFO - Online: Yes 15:31:16 INFO - Rotation: Supported 15:31:16 INFO - Return code: 0 15:31:16 INFO - Running post-action listener: _resource_record_post_action 15:31:16 INFO - Running post-run listener: _resource_record_post_run 15:31:18 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37590528; Write bytes: 666738176; Read time: 395; Write time: 2262 15:31:18 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 351488512; Write bytes: 351848448; Read time: 27026; Write time: 605 15:31:18 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 36668928; Write bytes: 301674496; Read time: 382; Write time: 1584 15:31:18 INFO - Running post-run listener: _upload_blobber_files 15:31:18 INFO - Blob upload gear active. 15:31:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:31:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:31:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:31:19 INFO - (blobuploader) - INFO - Open directory for files ... 15:31:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:31:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:31:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:22 INFO - (blobuploader) - INFO - Done attempting. 15:31:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:31:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:26 INFO - (blobuploader) - INFO - Done attempting. 15:31:26 INFO - (blobuploader) - INFO - Iteration through files over. 15:31:26 INFO - Return code: 0 15:31:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:31:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:31:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/691ca72708268aa15b0007ccf6083a1143ab0edc3b380f3f36b2e701b50c892750308f9200e8685aa7645d9bf844e98696945c7712c27bed33a8158ae26170e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d38ea3075d5f255e5fae555d529fecb86187ca6d6b4c5ef7b4de7ad99d9311c4c0ec7088da2a739976e8a6332f54be00d0e5889e1a8151d539a3d386bae6bec"} 15:31:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:31:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:31:26 INFO - Contents: 15:31:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/691ca72708268aa15b0007ccf6083a1143ab0edc3b380f3f36b2e701b50c892750308f9200e8685aa7645d9bf844e98696945c7712c27bed33a8158ae26170e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d38ea3075d5f255e5fae555d529fecb86187ca6d6b4c5ef7b4de7ad99d9311c4c0ec7088da2a739976e8a6332f54be00d0e5889e1a8151d539a3d386bae6bec"} 15:31:26 INFO - Running post-run listener: copy_logs_to_upload_dir 15:31:26 INFO - Copying logs to upload dir... 15:31:26 INFO - mkdir: /builds/slave/test/build/upload/logs 15:31:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.372693 ========= master_lag: 21.92 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-04-01 15:31:48.249012) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-01 15:31:48.252183) ========= 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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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/Mozilla-Aurora/sha512/691ca72708268aa15b0007ccf6083a1143ab0edc3b380f3f36b2e701b50c892750308f9200e8685aa7645d9bf844e98696945c7712c27bed33a8158ae26170e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d38ea3075d5f255e5fae555d529fecb86187ca6d6b4c5ef7b4de7ad99d9311c4c0ec7088da2a739976e8a6332f54be00d0e5889e1a8151d539a3d386bae6bec"} build_url:https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011885 build_url: 'https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/691ca72708268aa15b0007ccf6083a1143ab0edc3b380f3f36b2e701b50c892750308f9200e8685aa7645d9bf844e98696945c7712c27bed33a8158ae26170e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d38ea3075d5f255e5fae555d529fecb86187ca6d6b4c5ef7b4de7ad99d9311c4c0ec7088da2a739976e8a6332f54be00d0e5889e1a8151d539a3d386bae6bec"}' ========= master_lag: 2.40 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-01 15:31:50.667421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:31:50.667735) ========= 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.8mgG0slxuR/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.4EUvR3C6Mu/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.005150 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:31:50.789703) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-04-01 15:31:50.793065) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-04-01 15:31:55.067412) ========= ========= Total master_lag: 27.57 =========