builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0093 starttime: 1454984113.03 results: success (0) buildid: 20160208161423 builduid: 19affd9afebe4f66a62297b76fc90b47 revision: baf5dfffbc347cef3d7152f5b5d7ad7408a3f69d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.032211) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.032617) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.032948) ========= 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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.005478 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.082161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.082464) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.103664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.104030) ========= 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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.005849 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.152962) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.156324) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.156716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.156998) ========= 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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-08 18:15:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2016-02-08 18:15:13 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170853 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.481443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.481776) ========= 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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.026694 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:13.526387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-08 18:15:13.526774) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev baf5dfffbc347cef3d7152f5b5d7ad7408a3f69d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev baf5dfffbc347cef3d7152f5b5d7ad7408a3f69d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3fwBtgwG5x/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.ZP7u6tqDch/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-08 18:15:13,605 truncating revision to first 12 chars 2016-02-08 18:15:13,605 Setting DEBUG logging. 2016-02-08 18:15:13,605 attempt 1/10 2016-02-08 18:15:13,605 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/baf5dfffbc34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-08 18:15:15,533 unpacking tar archive at: fx-team-baf5dfffbc34/testing/mozharness/ program finished with exit code 0 elapsedTime=2.174263 ========= master_lag: 2.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-08 18:15:17.834993) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:17.835324) ========= echo baf5dfffbc347cef3d7152f5b5d7ad7408a3f69d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'baf5dfffbc347cef3d7152f5b5d7ad7408a3f69d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3fwBtgwG5x/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.ZP7u6tqDch/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 baf5dfffbc347cef3d7152f5b5d7ad7408a3f69d program finished with exit code 0 elapsedTime=0.005762 script_repo_revision: 'baf5dfffbc347cef3d7152f5b5d7ad7408a3f69d' ========= master_lag: 0.45 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:18.287275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:18.287565) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 18:15:18.310985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-08 18:15:18.314286) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3fwBtgwG5x/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.ZP7u6tqDch/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:15:18 INFO - MultiFileLogger online at 20160208 18:15:18 in /builds/slave/test 18:15:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:15:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:15:18 INFO - {'append_to_log': False, 18:15:18 INFO - 'base_work_dir': '/builds/slave/test', 18:15:18 INFO - 'blob_upload_branch': 'Fx-Team', 18:15:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:15:18 INFO - 'branch': 'Fx-Team', 18:15:18 INFO - 'buildbot_json_path': 'buildprops.json', 18:15:18 INFO - 'config_files': ('talos/mac_config.py',), 18:15:18 INFO - 'default_actions': ('clobber', 18:15:18 INFO - 'read-buildbot-config', 18:15:18 INFO - 'download-and-extract', 18:15:18 INFO - 'populate-webroot', 18:15:18 INFO - 'create-virtualenv', 18:15:18 INFO - 'install', 18:15:18 INFO - 'run-tests'), 18:15:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:15:18 INFO - 'download_minidump_stackwalk': True, 18:15:18 INFO - 'download_symbols': 'ondemand', 18:15:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:15:18 INFO - 'tooltool.py': '/tools/tooltool.py', 18:15:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:15:18 INFO - '/tools/misc-python/virtualenv.py')}, 18:15:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:15:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:15:18 INFO - 'installer_path': 'installer.exe', 18:15:18 INFO - 'log_level': 'info', 18:15:18 INFO - 'log_name': 'talos', 18:15:18 INFO - 'log_to_console': True, 18:15:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:15:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:15:18 INFO - 'opt_config_files': (), 18:15:18 INFO - 'pip_index': False, 18:15:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:15:18 INFO - 'cmd': ('bash', 18:15:18 INFO - '-c', 18:15:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:15:18 INFO - 'enabled': True, 18:15:18 INFO - 'halt_on_failure': False, 18:15:18 INFO - 'name': 'check_screen_resolution'},), 18:15:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:15:18 INFO - 'cmd': ('bash', 18:15:18 INFO - '-c', 18:15:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:15:18 INFO - 'enabled': True, 18:15:18 INFO - 'halt_on_failure': False, 18:15:18 INFO - 'name': 'check_screen_resolution'},), 18:15:18 INFO - 'run_cmd_checks_enabled': True, 18:15:18 INFO - 'sps_profile': False, 18:15:18 INFO - 'sps_profile_interval': 0, 18:15:18 INFO - 'suite': 'dromaeojs-e10s', 18:15:18 INFO - 'system_bits': '32', 18:15:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:15:18 INFO - 'title': 't-yosemite-r7-0093', 18:15:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:15:18 INFO - 'use_talos_json': True, 18:15:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:15:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:15:18 INFO - 'work_dir': 'build'} 18:15:18 INFO - ##### 18:15:18 INFO - ##### Running clobber step. 18:15:18 INFO - ##### 18:15:18 INFO - Running pre-action listener: _resource_record_pre_action 18:15:18 INFO - Running main action method: clobber 18:15:18 INFO - rmtree: /builds/slave/test/build 18:15:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:15:20 INFO - Running post-action listener: _resource_record_post_action 18:15:20 INFO - ##### 18:15:20 INFO - ##### Running read-buildbot-config step. 18:15:20 INFO - ##### 18:15:20 INFO - Running pre-action listener: _resource_record_pre_action 18:15:20 INFO - Running main action method: read_buildbot_config 18:15:20 INFO - Using buildbot properties: 18:15:20 INFO - { 18:15:20 INFO - "project": "", 18:15:20 INFO - "product": "firefox", 18:15:20 INFO - "script_repo_revision": "production", 18:15:20 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 18:15:20 INFO - "repository": "", 18:15:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 18:15:20 INFO - "buildid": "20160208161423", 18:15:20 INFO - "pgo_build": "False", 18:15:20 INFO - "basedir": "/builds/slave/test", 18:15:20 INFO - "buildnumber": 407, 18:15:20 INFO - "slavename": "t-yosemite-r7-0093", 18:15:20 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:15:20 INFO - "platform": "yosemite_r7", 18:15:20 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:15:20 INFO - "branch": "fx-team", 18:15:20 INFO - "repo_path": "integration/fx-team", 18:15:20 INFO - "revision": "baf5dfffbc347cef3d7152f5b5d7ad7408a3f69d", 18:15:20 INFO - "stage_platform": "macosx64", 18:15:20 INFO - "builduid": "19affd9afebe4f66a62297b76fc90b47", 18:15:20 INFO - "slavebuilddir": "test" 18:15:20 INFO - } 18:15:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 18:15:20 INFO - Running post-action listener: _resource_record_post_action 18:15:20 INFO - ##### 18:15:20 INFO - ##### Running download-and-extract step. 18:15:20 INFO - ##### 18:15:20 INFO - Running pre-action listener: _resource_record_pre_action 18:15:20 INFO - Running main action method: download_and_extract 18:15:20 INFO - mkdir: /builds/slave/test/build/tests 18:15:20 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')]} 18:15:20 INFO - https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:15:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/test_packages.json 18:15:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/test_packages.json 18:15:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:15:21 INFO - Downloaded 1277 bytes. 18:15:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:15:21 INFO - Using the following test package requirements: 18:15:21 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:15:21 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:15:21 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 18:15:21 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:15:21 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 18:15:21 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:15:21 INFO - u'jsshell-mac.zip'], 18:15:21 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:15:21 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 18:15:21 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:15:21 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:15:21 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 18:15:21 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:15:21 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 18:15:21 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:15:21 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 18:15:21 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:15:21 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:15:21 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 18:15:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:15:21 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')]} 18:15:21 INFO - https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:15:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:15:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:15:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:15:22 INFO - Downloaded 17753918 bytes. 18:15:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:15:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:15:25 INFO - Return code: 0 18:15:25 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:15: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')]} 18:15:25 INFO - https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:15:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:15:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:15:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:15:27 INFO - Downloaded 17753918 bytes. 18:15:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:15:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:15:30 INFO - Return code: 0 18:15: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')]} 18:15:30 INFO - https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:15:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:15:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:15:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:15:32 INFO - Downloaded 10706547 bytes. 18:15:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:15:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:15:32 INFO - Return code: 0 18:15:32 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')]} 18:15:32 INFO - https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:15:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:15:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:15:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 18:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 18:15:35 INFO - Downloaded 111838909 bytes. 18:15:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:15:35 INFO - mkdir: /builds/slave/test/properties 18:15:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:15:35 INFO - Writing to file /builds/slave/test/properties/build_url 18:15:35 INFO - Contents: 18:15:35 INFO - build_url:https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:15:36 INFO - Running post-action listener: _resource_record_post_action 18:15:36 INFO - Running post-action listener: set_extra_try_arguments 18:15:36 INFO - ##### 18:15:36 INFO - ##### Running populate-webroot step. 18:15:36 INFO - ##### 18:15:36 INFO - Running pre-action listener: _resource_record_pre_action 18:15:36 INFO - Running main action method: populate_webroot 18:15:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:15:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:15:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:15:36 INFO - '--tppagecycles', 18:15:36 INFO - '7'], 18:15:36 INFO - 'tests': ['tsvgm']}}, 18:15:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:15:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:15:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:15:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:15:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:15:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:15:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:15:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:36 INFO - 'talos_options': ['--e10s'], 18:15:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:15:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:36 INFO - 'tests': ['damp', 'tps']}, 18:15:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:36 INFO - 'talos_options': ['--e10s'], 18:15:36 INFO - 'tests': ['damp', 'tps']}, 18:15:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:15:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:15:36 INFO - 'other': {'tests': ['a11yr', 18:15:36 INFO - 'ts_paint', 18:15:36 INFO - 'tpaint', 18:15:36 INFO - 'sessionrestore', 18:15:36 INFO - 'sessionrestore_no_auto_restore']}, 18:15:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:15:36 INFO - 'tests': ['a11yr', 18:15:36 INFO - 'ts_paint', 18:15:36 INFO - 'tpaint', 18:15:36 INFO - 'sessionrestore', 18:15:36 INFO - 'sessionrestore_no_auto_restore']}, 18:15:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:15:36 INFO - 'tests': ['a11yr', 18:15:36 INFO - 'ts_paint', 18:15:36 INFO - 'tpaint', 18:15:36 INFO - 'sessionrestore', 18:15:36 INFO - 'sessionrestore_no_auto_restore']}, 18:15:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:15:36 INFO - 'tests': ['a11yr', 18:15:36 INFO - 'ts_paint', 18:15:36 INFO - 'tpaint', 18:15:36 INFO - 'sessionrestore', 18:15:36 INFO - 'sessionrestore_no_auto_restore']}, 18:15:36 INFO - 'other_l64': {'tests': ['a11yr', 18:15:36 INFO - 'ts_paint', 18:15:36 INFO - 'tpaint', 18:15:36 INFO - 'sessionrestore', 18:15:36 INFO - 'sessionrestore_no_auto_restore']}, 18:15:36 INFO - 'other_nol64': {'tests': ['a11yr', 18:15:36 INFO - 'ts_paint', 18:15:36 INFO - 'tpaint', 18:15:36 INFO - 'sessionrestore', 18:15:36 INFO - 'sessionrestore_no_auto_restore']}, 18:15:36 INFO - 'svgr': {'tests': ['tsvgx', 18:15:36 INFO - 'tsvgr_opacity', 18:15:36 INFO - 'tart', 18:15:36 INFO - 'tscrollx', 18:15:36 INFO - 'cart']}, 18:15:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:15:36 INFO - 'tests': ['tsvgx', 18:15:36 INFO - 'tsvgr_opacity', 18:15:36 INFO - 'tart', 18:15:36 INFO - 'tscrollx', 18:15:36 INFO - 'cart']}, 18:15:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:36 INFO - 'tests': ['tp5o']}, 18:15:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:36 INFO - 'talos_options': ['--e10s'], 18:15:36 INFO - 'tests': ['tp5o']}, 18:15:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:36 INFO - 'talos_options': ['--xperf_path', 18:15:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:15:36 INFO - 'tests': ['tp5n']}, 18:15:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:36 INFO - 'talos_options': ['--e10s', 18:15:36 INFO - '--xperf_path', 18:15:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:15:36 INFO - 'tests': ['tp5n']}}, 18:15:36 INFO - 'talos.zip': {'path': '', 18:15:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:15:36 INFO - Running post-action listener: _resource_record_post_action 18:15:36 INFO - ##### 18:15:36 INFO - ##### Running create-virtualenv step. 18:15:36 INFO - ##### 18:15:36 INFO - Running pre-action listener: _resource_record_pre_action 18:15:36 INFO - Running main action method: create_virtualenv 18:15:36 INFO - Creating virtualenv /builds/slave/test/build/venv 18:15:36 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 18:15:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:15:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:15:36 INFO - Using real prefix '/tools/python27' 18:15:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:15:37 INFO - Installing distribute.............................................................................................................................................................................................done. 18:15:40 INFO - Installing pip.................done. 18:15:40 INFO - Return code: 0 18:15:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10142ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb69ea7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012d2d30>, '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 0x1010f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012c9b20>, '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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:15:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3fwBtgwG5x/Render', 18:15:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:15:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:15:40 INFO - 'HOME': '/Users/cltbld', 18:15:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:15:40 INFO - 'LOGNAME': 'cltbld', 18:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:40 INFO - 'MOZ_NO_REMOTE': '1', 18:15:40 INFO - 'NO_EM_RESTART': '1', 18:15:40 INFO - 'PAGER': '/bin/cat', 18:15:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:40 INFO - 'PWD': '/builds/slave/test', 18:15:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:15:40 INFO - 'SHELL': '/bin/bash', 18:15:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZP7u6tqDch/Listeners', 18:15:40 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:15:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:15:40 INFO - 'USER': 'cltbld', 18:15:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:15:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:40 INFO - 'XPC_FLAGS': '0x0', 18:15:40 INFO - 'XPC_SERVICE_NAME': '0', 18:15:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:40 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 18:15:40 INFO - Cleaning up... 18:15:40 INFO - Return code: 0 18:15:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10142ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb69ea7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012d2d30>, '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 0x1010f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012c9b20>, '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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:15:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3fwBtgwG5x/Render', 18:15:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:15:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:15:40 INFO - 'HOME': '/Users/cltbld', 18:15:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:15:40 INFO - 'LOGNAME': 'cltbld', 18:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:40 INFO - 'MOZ_NO_REMOTE': '1', 18:15:40 INFO - 'NO_EM_RESTART': '1', 18:15:40 INFO - 'PAGER': '/bin/cat', 18:15:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:40 INFO - 'PWD': '/builds/slave/test', 18:15:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:15:40 INFO - 'SHELL': '/bin/bash', 18:15:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZP7u6tqDch/Listeners', 18:15:40 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:15:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:15:40 INFO - 'USER': 'cltbld', 18:15:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:15:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:40 INFO - 'XPC_FLAGS': '0x0', 18:15:40 INFO - 'XPC_SERVICE_NAME': '0', 18:15:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:40 INFO - Downloading/unpacking psutil>=0.7.1 18:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:15:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:15:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:15:43 INFO - Installing collected packages: psutil 18:15:43 INFO - Running setup.py install for psutil 18:15:43 INFO - building 'psutil._psutil_osx' extension 18:15:43 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 18:15:44 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 18:15:44 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 18:15:44 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 18:15:44 INFO - building 'psutil._psutil_posix' extension 18:15:44 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 18:15:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:15:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:15:44 INFO - ^ 18:15:44 INFO - 1 warning generated. 18:15:44 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 18:15:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:15:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:15:44 INFO - Successfully installed psutil 18:15:44 INFO - Cleaning up... 18:15:44 INFO - Return code: 0 18:15:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:15: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')]} 18:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15: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')]} 18:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15: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', '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 0x10142ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb69ea7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012d2d30>, '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 0x1010f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012c9b20>, '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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:15: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:15: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 mozsystemmonitor==0.0.0 18:15:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3fwBtgwG5x/Render', 18:15:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:15:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:15:44 INFO - 'HOME': '/Users/cltbld', 18:15:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:15:44 INFO - 'LOGNAME': 'cltbld', 18:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:44 INFO - 'MOZ_NO_REMOTE': '1', 18:15:44 INFO - 'NO_EM_RESTART': '1', 18:15:44 INFO - 'PAGER': '/bin/cat', 18:15:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:44 INFO - 'PWD': '/builds/slave/test', 18:15:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:15:44 INFO - 'SHELL': '/bin/bash', 18:15:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZP7u6tqDch/Listeners', 18:15:44 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:15:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:15:44 INFO - 'USER': 'cltbld', 18:15:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:15:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:44 INFO - 'XPC_FLAGS': '0x0', 18:15:44 INFO - 'XPC_SERVICE_NAME': '0', 18:15:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:15:47 INFO - Installing collected packages: mozsystemmonitor 18:15:47 INFO - Running setup.py install for mozsystemmonitor 18:15:47 INFO - Successfully installed mozsystemmonitor 18:15:47 INFO - Cleaning up... 18:15:47 INFO - Return code: 0 18:15:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10142ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb69ea7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012d2d30>, '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 0x1010f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012c9b20>, '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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:15:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:15:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3fwBtgwG5x/Render', 18:15:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:15:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:15:47 INFO - 'HOME': '/Users/cltbld', 18:15:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:15:47 INFO - 'LOGNAME': 'cltbld', 18:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:47 INFO - 'MOZ_NO_REMOTE': '1', 18:15:47 INFO - 'NO_EM_RESTART': '1', 18:15:47 INFO - 'PAGER': '/bin/cat', 18:15:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:47 INFO - 'PWD': '/builds/slave/test', 18:15:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:15:47 INFO - 'SHELL': '/bin/bash', 18:15:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZP7u6tqDch/Listeners', 18:15:47 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:15:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:15:47 INFO - 'USER': 'cltbld', 18:15:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:15:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:47 INFO - 'XPC_FLAGS': '0x0', 18:15:47 INFO - 'XPC_SERVICE_NAME': '0', 18:15:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:47 INFO - Downloading/unpacking blobuploader==1.2.4 18:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:50 INFO - Downloading blobuploader-1.2.4.tar.gz 18:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:15:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:15:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:51 INFO - Downloading docopt-0.6.1.tar.gz 18:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:15:51 INFO - Installing collected packages: blobuploader, requests, docopt 18:15:51 INFO - Running setup.py install for blobuploader 18:15:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:15:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:15:51 INFO - Running setup.py install for requests 18:15:52 INFO - Running setup.py install for docopt 18:15:52 INFO - Successfully installed blobuploader requests docopt 18:15:52 INFO - Cleaning up... 18:15:52 INFO - Return code: 0 18:15:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:52 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 0x10142ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb69ea7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012d2d30>, '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 0x1010f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012c9b20>, '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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:15:52 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 18:15:52 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 18:15:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3fwBtgwG5x/Render', 18:15:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:15:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:15:52 INFO - 'HOME': '/Users/cltbld', 18:15:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:15:52 INFO - 'LOGNAME': 'cltbld', 18:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:52 INFO - 'MOZ_NO_REMOTE': '1', 18:15:52 INFO - 'NO_EM_RESTART': '1', 18:15:52 INFO - 'PAGER': '/bin/cat', 18:15:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:52 INFO - 'PWD': '/builds/slave/test', 18:15:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:15:52 INFO - 'SHELL': '/bin/bash', 18:15:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZP7u6tqDch/Listeners', 18:15:52 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:15:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:15:52 INFO - 'USER': 'cltbld', 18:15:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:15:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:52 INFO - 'XPC_FLAGS': '0x0', 18:15:52 INFO - 'XPC_SERVICE_NAME': '0', 18:15:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:15:52 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-7lBfpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:15:52 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-mM9fqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:15:52 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Qk9jhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:15:52 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Wk_p4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:15:52 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-QFEkeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:15:53 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-3R7UsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:15:53 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-NriVTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:15:53 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-z69x7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:15:53 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-3GN6P8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:15:53 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-ABoWJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:15:53 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-QBS5Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:15:53 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-KAo7aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:15:53 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-QuGo7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:15:53 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-2HrBvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:15:53 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-hGjM_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:15:54 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-KSJoIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:15:54 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-zg4A6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:15:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:15:54 INFO - Running setup.py install for manifestparser 18:15:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:15:54 INFO - Running setup.py install for mozcrash 18:15:54 INFO - Running setup.py install for mozdebug 18:15:54 INFO - Running setup.py install for mozdevice 18:15:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:15:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:15:54 INFO - Running setup.py install for mozfile 18:15:55 INFO - Running setup.py install for mozhttpd 18:15:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:15:55 INFO - Running setup.py install for mozinfo 18:15:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:15:55 INFO - Running setup.py install for mozInstall 18:15:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:15:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:15:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:15:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:15:55 INFO - Running setup.py install for mozleak 18:15:55 INFO - Running setup.py install for mozlog 18:15:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:15:55 INFO - Running setup.py install for moznetwork 18:15:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:15:55 INFO - Running setup.py install for mozprocess 18:15:56 INFO - Running setup.py install for mozprofile 18:15:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:15:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:15:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:15:56 INFO - Running setup.py install for mozrunner 18:15:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:15:56 INFO - Running setup.py install for mozscreenshot 18:15:56 INFO - Running setup.py install for moztest 18:15:56 INFO - Running setup.py install for mozversion 18:15:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:15:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:15:56 INFO - Cleaning up... 18:15:56 INFO - Return code: 0 18:15:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:15: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')]} 18:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15: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')]} 18:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:56 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 0x10142ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb69ea7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012d2d30>, '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 0x1010f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012c9b20>, '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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:15:56 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 18:15:56 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 18:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3fwBtgwG5x/Render', 18:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:15:56 INFO - 'HOME': '/Users/cltbld', 18:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:15:56 INFO - 'LOGNAME': 'cltbld', 18:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:56 INFO - 'MOZ_NO_REMOTE': '1', 18:15:56 INFO - 'NO_EM_RESTART': '1', 18:15:56 INFO - 'PAGER': '/bin/cat', 18:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:56 INFO - 'PWD': '/builds/slave/test', 18:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:15:56 INFO - 'SHELL': '/bin/bash', 18:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZP7u6tqDch/Listeners', 18:15:56 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:15:56 INFO - 'USER': 'cltbld', 18:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:56 INFO - 'XPC_FLAGS': '0x0', 18:15:56 INFO - 'XPC_SERVICE_NAME': '0', 18:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:15:57 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-qs3jdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:15:57 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)) 18:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:15:57 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-iUbY0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:15:57 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-aW2oTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:15:57 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)) 18:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:15:57 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-4wOA9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:15:57 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)) 18:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:15:57 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Dd3Ihl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:15:57 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)) 18:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:15:57 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-wZ2Zgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:15:57 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)) 18:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:15:57 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-C0h_AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:15:57 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)) 18:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:15:57 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-ZzOONJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:15:57 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)) 18:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:15:57 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-KBQz8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:15:58 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)) 18:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:15:58 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-M3yNOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:15:58 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)) 18:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:15:58 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-X8htvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:15:58 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)) 18:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:15:58 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-qrwW5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:15:58 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)) 18:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:15:58 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-qOuSun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:15:58 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)) 18:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:15:58 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-RaiDVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:15:58 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)) 18:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:15:58 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-QIb34b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:15:58 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)) 18:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:15:58 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-4eH4sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:15:58 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)) 18:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:15:58 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-K1TqcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:15:58 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)) 18:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:15:58 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)) 18:15:58 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)) 18:15:58 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)) 18:15:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:01 INFO - Downloading blessings-1.6.tar.gz 18:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:16:01 INFO - Installing collected packages: blessings 18:16:01 INFO - Running setup.py install for blessings 18:16:01 INFO - Successfully installed blessings 18:16:01 INFO - Cleaning up... 18:16:01 INFO - Return code: 0 18:16:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:16:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:16:01 INFO - Reading from file tmpfile_stdout 18:16:01 INFO - Current package versions: 18:16:01 INFO - blessings == 1.6 18:16:01 INFO - blobuploader == 1.2.4 18:16:01 INFO - docopt == 0.6.1 18:16:01 INFO - manifestparser == 1.1 18:16:01 INFO - mozInstall == 1.12 18:16:01 INFO - mozcrash == 0.16 18:16:01 INFO - mozdebug == 0.1 18:16:01 INFO - mozdevice == 0.48 18:16:01 INFO - mozfile == 1.2 18:16:01 INFO - mozhttpd == 0.7 18:16:01 INFO - mozinfo == 0.9 18:16:01 INFO - mozleak == 0.1 18:16:01 INFO - mozlog == 3.1 18:16:01 INFO - moznetwork == 0.27 18:16:01 INFO - mozprocess == 0.22 18:16:01 INFO - mozprofile == 0.28 18:16:01 INFO - mozrunner == 6.11 18:16:01 INFO - mozscreenshot == 0.1 18:16:01 INFO - mozsystemmonitor == 0.0 18:16:01 INFO - moztest == 0.7 18:16:01 INFO - mozversion == 1.4 18:16:01 INFO - psutil == 3.1.1 18:16:01 INFO - requests == 1.2.3 18:16:01 INFO - wsgiref == 0.1.2 18:16:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:01 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 0x10142ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb69ea7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012d2d30>, '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 0x1010f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012c9b20>, '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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:16:01 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 18:16:01 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 18:16:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3fwBtgwG5x/Render', 18:16:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:16:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:16:01 INFO - 'HOME': '/Users/cltbld', 18:16:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:16:01 INFO - 'LOGNAME': 'cltbld', 18:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:01 INFO - 'MOZ_NO_REMOTE': '1', 18:16:01 INFO - 'NO_EM_RESTART': '1', 18:16:01 INFO - 'PAGER': '/bin/cat', 18:16:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:01 INFO - 'PWD': '/builds/slave/test', 18:16:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:16:01 INFO - 'SHELL': '/bin/bash', 18:16:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZP7u6tqDch/Listeners', 18:16:01 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:16:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:16:01 INFO - 'USER': 'cltbld', 18:16:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:16:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:01 INFO - 'XPC_FLAGS': '0x0', 18:16:01 INFO - 'XPC_SERVICE_NAME': '0', 18:16:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:02 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)) 18:16:02 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)) 18:16:02 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)) 18:16:02 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)) 18:16:02 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)) 18:16:02 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)) 18:16:02 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)) 18:16:02 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)) 18:16:02 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)) 18:16:02 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)) 18:16:02 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)) 18:16:02 INFO - Cleaning up... 18:16:02 INFO - Return code: 0 18:16:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:16:02 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')]} 18:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:02 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')]} 18:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:02 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 0x10142ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb69ea7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012d2d30>, '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 0x1010f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012c9b20>, '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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:16:02 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 18:16:02 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 18:16:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3fwBtgwG5x/Render', 18:16:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:16:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:16:02 INFO - 'HOME': '/Users/cltbld', 18:16:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:16:02 INFO - 'LOGNAME': 'cltbld', 18:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:02 INFO - 'MOZ_NO_REMOTE': '1', 18:16:02 INFO - 'NO_EM_RESTART': '1', 18:16:02 INFO - 'PAGER': '/bin/cat', 18:16:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:02 INFO - 'PWD': '/builds/slave/test', 18:16:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:16:02 INFO - 'SHELL': '/bin/bash', 18:16:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZP7u6tqDch/Listeners', 18:16:02 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:16:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:16:02 INFO - 'USER': 'cltbld', 18:16:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:16:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:02 INFO - 'XPC_FLAGS': '0x0', 18:16:02 INFO - 'XPC_SERVICE_NAME': '0', 18:16:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:02 INFO - Downloading/unpacking jsonschema 18:16:02 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 18:16:02 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 18:16:02 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 18:16:02 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 18:16:02 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 18:16:02 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 18:16:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:16:04 INFO - Downloading/unpacking functools32 (from jsonschema) 18:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:05 INFO - Downloading functools32-3.2.3-2.tar.gz 18:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:16:05 INFO - warning: no files found matching '*.txt' 18:16:05 INFO - no previously-included directories found matching 'build' 18:16:05 INFO - no previously-included directories found matching 'dist' 18:16:05 INFO - no previously-included directories found matching '.git*' 18:16:05 INFO - Installing collected packages: jsonschema, functools32 18:16:05 INFO - Running setup.py install for functools32 18:16:05 INFO - warning: no files found matching '*.txt' 18:16:05 INFO - no previously-included directories found matching 'build' 18:16:05 INFO - no previously-included directories found matching 'dist' 18:16:05 INFO - no previously-included directories found matching '.git*' 18:16:05 INFO - Successfully installed jsonschema functools32 18:16:05 INFO - Cleaning up... 18:16:05 INFO - Return code: 0 18:16:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:16:05 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')]} 18:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:05 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')]} 18:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:05 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 0x10142ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb69ea7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012d2d30>, '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 0x1010f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012c9b20>, '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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:16:05 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 18:16:05 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 18:16:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3fwBtgwG5x/Render', 18:16:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:16:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:16:05 INFO - 'HOME': '/Users/cltbld', 18:16:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:16:05 INFO - 'LOGNAME': 'cltbld', 18:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:05 INFO - 'MOZ_NO_REMOTE': '1', 18:16:05 INFO - 'NO_EM_RESTART': '1', 18:16:05 INFO - 'PAGER': '/bin/cat', 18:16:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:05 INFO - 'PWD': '/builds/slave/test', 18:16:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:16:05 INFO - 'SHELL': '/bin/bash', 18:16:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZP7u6tqDch/Listeners', 18:16:05 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:16:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:16:05 INFO - 'USER': 'cltbld', 18:16:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:16:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:05 INFO - 'XPC_FLAGS': '0x0', 18:16:05 INFO - 'XPC_SERVICE_NAME': '0', 18:16:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:05 INFO - Downloading/unpacking flake8 18:16:05 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 18:16:05 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 18:16:05 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 18:16:05 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 18:16:05 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 18:16:05 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 18:16:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:16:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:16:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:16:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:16:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:16:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:16:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:16:09 INFO - no previously-included directories found matching 'docs/_build' 18:16:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:16:09 INFO - Running setup.py install for pep8 18:16:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:16:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:16:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:16:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:16:09 INFO - no previously-included directories found matching 'docs/_build' 18:16:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:16:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:16:09 INFO - Cleaning up... 18:16:09 INFO - Return code: 0 18:16:09 INFO - Running post-action listener: _resource_record_post_action 18:16:09 INFO - Running post-action listener: _start_resource_monitoring 18:16:09 INFO - Starting resource monitoring. 18:16:09 INFO - ##### 18:16:09 INFO - ##### Running install step. 18:16:09 INFO - ##### 18:16:09 INFO - Running pre-action listener: _resource_record_pre_action 18:16:09 INFO - Running main action method: install 18:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:16:09 INFO - Reading from file tmpfile_stdout 18:16:09 INFO - Detecting whether we're running mozinstall >=1.0... 18:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:16:10 INFO - Reading from file tmpfile_stdout 18:16:10 INFO - Output received: 18:16:10 INFO - Usage: mozinstall [options] installer 18:16:10 INFO - Options: 18:16:10 INFO - -h, --help show this help message and exit 18:16:10 INFO - -d DEST, --destination=DEST 18:16:10 INFO - Directory to install application into. [default: 18:16:10 INFO - "/builds/slave/test"] 18:16:10 INFO - --app=APP Application being installed. [default: firefox] 18:16:10 INFO - mkdir: /builds/slave/test/build/application 18:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:16:43 INFO - Reading from file tmpfile_stdout 18:16:43 INFO - Output received: 18:16:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:16:43 INFO - Running post-action listener: _resource_record_post_action 18:16:43 INFO - ##### 18:16:43 INFO - ##### Running run-tests step. 18:16:43 INFO - ##### 18:16:43 INFO - Running pre-action listener: _resource_record_pre_action 18:16:43 INFO - Running main action method: run_tests 18:16:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:16:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:16:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:16:43 INFO - 2016-02-08 18:16:43.837 screenresolution[1647:7639] starting screenresolution argv=screenresolution get 18:16:43 INFO - 2016-02-08 18:16:43.840 screenresolution[1647:7639] Display 0: 1600x1200x32@60 18:16:43 INFO - 2016-02-08 18:16:43.846 screenresolution[1648:7641] starting screenresolution argv=screenresolution list 18:16:43 INFO - Available Modes on Display 0 18:16:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:16:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:16:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:16:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:16:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:16:44 INFO - Intel Iris: 18:16:44 INFO - Chipset Model: Intel Iris 18:16:44 INFO - Type: GPU 18:16:44 INFO - Bus: Built-In 18:16:44 INFO - VRAM (Dynamic, Max): 1536 MB 18:16:44 INFO - Vendor: Intel (0x8086) 18:16:44 INFO - Device ID: 0x0a2e 18:16:44 INFO - Revision ID: 0x0009 18:16:44 INFO - Displays: 18:16:44 INFO - Display: 18:16:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:16:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:16:44 INFO - Display Serial Number: 1600x1200 60 18:16:44 INFO - Main Display: Yes 18:16:44 INFO - Mirror: Off 18:16:44 INFO - Online: Yes 18:16:44 INFO - Rotation: Supported 18:16:44 INFO - Return code: 0 18:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:16:44 INFO - Python 2.7.3 18:16:44 INFO - Return code: 0 18:16:44 INFO - grabbing minidump binary from tooltool 18:16: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')]} 18:16:44 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 0x1012d2d30>, '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 0x1010f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012c9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:16:44 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 18:16:44 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 18:16:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:16:44 INFO - Return code: 0 18:16:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:16:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:16:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:16:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:16:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:16:45 INFO - Return code: 0 18:16:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0093', '--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 18:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0093 --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 18:16:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3fwBtgwG5x/Render', 18:16:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:16:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:16:45 INFO - 'HOME': '/Users/cltbld', 18:16:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:16:45 INFO - 'LOGNAME': 'cltbld', 18:16:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:16:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:45 INFO - 'MOZ_NO_REMOTE': '1', 18:16:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:16:45 INFO - 'NO_EM_RESTART': '1', 18:16:45 INFO - 'PAGER': '/bin/cat', 18:16:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:45 INFO - 'PWD': '/builds/slave/test', 18:16:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:16:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:16:45 INFO - 'SHELL': '/bin/bash', 18:16:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZP7u6tqDch/Listeners', 18:16:45 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:16:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:16:45 INFO - 'USER': 'cltbld', 18:16:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:16:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:45 INFO - 'XPC_FLAGS': '0x0', 18:16:45 INFO - 'XPC_SERVICE_NAME': '0', 18:16:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:16:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0093', '--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 18:16:45 INFO - mozversion application_buildid: 20160208161423 18:16:45 INFO - mozversion application_changeset: baf5dfffbc347cef3d7152f5b5d7ad7408a3f69d 18:16:45 INFO - mozversion application_display_name: Nightly 18:16:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:16:45 INFO - mozversion application_name: Firefox 18:16:45 INFO - mozversion application_remotingname: firefox 18:16:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:16:45 INFO - mozversion application_vendor: Mozilla 18:16:45 INFO - mozversion application_version: 47.0a1 18:16:45 INFO - mozversion platform_buildid: 20160208161423 18:16:45 INFO - mozversion platform_changeset: baf5dfffbc347cef3d7152f5b5d7ad7408a3f69d 18:16:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:16:45 INFO - mozversion platform_version: 47.0a1 18:16:45 INFO - using testdate: 1454984205 18:16:45 INFO - actual date: 1454984205 18:16:46 INFO - starting webserver on 'localhost:49283' 18:16:46 INFO - SUITE-START | Running 2 tests 18:16:46 INFO - TEST-START | dromaeo_css 18:16:46 INFO - operating with platform_type : mac_ 18:16:46 INFO - Initialising browser for dromaeo_css test... 18:16:46 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpNbhdcZ/profile http://localhost:49283/getInfo.html) 18:16:48 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 18:16:48 INFO - PROCESS | 1666 | colorDepth:24 18:16:48 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 18:16:48 INFO - PROCESS | 1666 | __metrics 18:16:49 INFO - TEST-INFO | 1666: exit 0 18:16:49 INFO - Browser initialized. 18:16:49 INFO - Running cycle 1/1 for dromaeo_css test... 18:16:49 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpNbhdcZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:17:01 INFO - PROCESS | 1670 | RSS: Main: 258973696 18:17:01 INFO - PROCESS | 1670 | 18:17:51 INFO - PROCESS | 1670 | 1454984271170 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] 18:20:01 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 18:20:03 INFO - PROCESS | 1670 | RSS: Main: 271560704 18:20:03 INFO - PROCESS | 1670 | 18:23:05 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 18:23:05 INFO - PROCESS | 1670 | RSS: Main: 282877952 18:23:05 INFO - PROCESS | 1670 | 18:26:07 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 18:26:08 INFO - PROCESS | 1670 | RSS: Main: 284020736 18:26:08 INFO - PROCESS | 1670 | 18:29:09 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 18:29:10 INFO - PROCESS | 1670 | RSS: Main: 287141888 18:29:10 INFO - PROCESS | 1670 | 18:32:13 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 18:32:13 INFO - PROCESS | 1670 | RSS: Main: 290185216 18:32:13 INFO - PROCESS | 1670 | 18:35:16 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 18:35:16 INFO - PROCESS | 1670 | RSS: Main: 291102720 18:35:16 INFO - PROCESS | 1670 | 18:35:16 INFO - PROCESS | 1670 | __start_tp_report 18:35:16 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 18:35:16 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 18:35:16 INFO - PROCESS | 1670 | |i|pagename|runs| 18:35:16 INFO - PROCESS | 1670 | |0;dojo.html;3485.4074807282764;3577.40972739498;3609.133807886108;3624.8006359650226;3626.2747450509887;5659;5745.6839873806975;5778.075507918734;5784.2769653793275;5785.3346865110525;5702.914456283159;5715.914261286084;5833.416658334165;5900.88198236035;5912.024515954862;5187.6628019178725;5204.687718736869;5208.0365132450615;5279.815206467774;5309.62832601718;5259.684418934857;5287.947120528784;5323.121684922003;5325.440828712987;5367.946320536784;5119.052975199581;5143.485651434864;5239.083160446907;5252.894942101137;5264.315638966948;5222.2427747976335;5238.371395432534;5251.973740131275;5287.312649355559;5301.920471192935;5093.5415812576675;5203.687778733288;5238.659487133325;5239.109351410231;5254.789808407659;5592.832215033555;5738.598298119134;5743.913841292384;5755.856103597402;5780.8843823123725;6222.097795819626;6321.494280457552;6336.2396512418345;6336.619802811846;6341.778037768656;5207.244949482341;6209.441150296449;6254.687265636746;6297.244330680348;6301.275353334334;5904.254521647455;5908.3205431375945;5912.556558258148;5913.9112913306335;5988.371221021774;5884.176215329857;6235.033569796688;6376.29860715321;6383.96808015957;6385.329540398284;6142.5294708490455;6190.288116866528;6220.564560480723;6226.40849119333;6247.656378899204;5475.151351540518;6273.560850740404;6292.119103325538;6310.085037669604;6310.810675679737;6137.4689182037;6191.102290167991;6273.811785646347;6286.9056964145575;6315.621062736251;6178.62928224308;6243.687815609202;6293.527985401113;6300.30696623371;6302.149209856702;4891.559759621651;4926.852194434173;4960.379952505937;4961.603071754251;4972.378452693413;4373.453318335208;4415.66882483815;4415.889602759957;4451.888702782457;4527.61515271199;5849.941500585025;5859.677717725566;5897.823065307962;5909.881802363929;5958.612690175125;6114.601521188728;6168.691565421711;6265.686626030784;6327.873442531123;6337.683115844282;5816.592838501264;5863.765449382062;5867.3839246879315;5902.704864756745;5936.079907614327;5349.732513374393;5390.568754499631;5428.185772134211;5437.184422336682;5455.618106732491;6253.937460625336;6318.842028949313;6416.390442907917;6445.129907462432;6450.870982580416;6226.1905952225925;6244.281907580505;6269.467095296951;6278.686065696788;6307.684615769285;6047.879042419215;6293.842653933688;6297.905531417124;6311.96844015777;6313.96843015782;6134.375358695336;6135.478484328882;6255.468285195628;6278;6286.308506064421;6241.719122639583;6247.406496382836;6308.116863639186;6309.211348581427;6313.6843157841;6037.607555508878;6116.960116780069;6122.326544080059;6200.56596038273;6213.37866213375;4625.236835922035;6168.9691551541955;6202.41077097675;6214.161088253028;6353.555251132377;6018.849528761816;6065.909011364744;6067.696615169312;6081.483073938588;6089.573729839046;6038.607490513103;6113.263474096151;6194.845128871814;6201;6224.937750622617;5242.820365417903;5902.61632993854;6081.422264884829;6091.0558863376245;6096.512279017757 18:35:16 INFO - PROCESS | 1670 | |1;ext.html;445.95986361227483;450.0512779664055;504.81321910892973;542.2841848759634;570.9628874123182;33113.33773324538;37811.81094094529;38079.42880856783;38461.42307865384;38554.61445385549;39834.60165398345;40102;40248.993775155635;40371.990700232505;40376.79811600938;8052.758417247463;8324.417290789646;8905.753194552768;9281.350305478636;9502.049795020477;9398.953005234964;9599.856002159973;9613.471259080748;9655.710328690151;9692.612295508172;8999.325050621197;9599.712008639752;9630.951845240765;9639.987801280835;9665.371750836173;8032.959835200787;9571.234301255883;9663.130318271355;9669.468179250138;9682.46746428946;9370.906290937071;9536.952315238379;9538.904610953941;9545.713628591153;9560.139587437094;38263.32156749029;38380.61619383798;38797.61202387968;38812.611873881186;38905.221895562216;2964.5553167024905;3150.401423729484;3233.757468189895;3454.481827725836;3523.8766643167364;27765;27841.303967400978;27997.72002279992;28128.859355703295;28219.57670634942;2661.828795330068;2779.471900338949;2781.749642532182;2834.6740124885696;2914.7959642825012;453379.1993120106;461500.9999999966;515326.6934661286;516075;519669;58230.54423639443;68052;68133;69361;69392.6530367355;65766;66041.6697916517;66072;66513;66537;16401.93387429813;16421.91789041047;16606.584835379213;16634.33462661504;16641.33434662624;12635.74728505443;12658.683532911567;12781.041421893395;12790.10469267161;12918.870811291954;20949.743015419124;21287.61630494013;21341;21430.357089287347;21626.810525421253;8548.102449242864;9230.215431688383;9272.30457715674;9274.489903055397;9288.489133097744;941.764558860285;942.2132519346422;1021.7292417509366;1031.2111234905303;1113.2207454781685;29585.408291834043;29871.850640747092;29936.25159371033;30598;30787;1043.6034306963456;1096.4846522134585;1113.6714669172452;1143.6969203161002;1157.866845312783;15087.924560377129;15301.540953771182;15427.641107082536;15530.378784848706;15616.76574851378;553751;557567;560090;560227;561221;58603;59000.40999589949;59385;59628.80742385128;59805.80388392295;1426.4793350427226;1427.7786943023848;1428.8212224914487;1455.272363818091;1469.7868809022846;29621.25946851346;29875.402491949604;30128;30207.69792302049;30391.720620953958;48943.75528122479;52204;52285.47714522806;52794.736026319624;52810.207846883095;515216;517969;520606;523791;524947;28666.713332866406;32978.83510582432;33393.83303083469;33439.49840752439;33920.15199620029;40324;41682.95792605209;42098.73703788891;42645.78677106595;42829.78585107055;40216.7989160064;40963.97590060272;41199.58800412077;41983.160336793706;42283.36574951317;38302.808485957394;38997.41503877387;39029.609703903734;39220;39336.803315983234;38435.6156438432;38891.416628751154;39270.01824954399;39321;40908.1818363637;31630.525542116426;37314.91707185432;38275.80862095672;38326.425103624024;38378.61621383751;21767.38888250523;25051.57560362043;26151.215463536126;26714.465710686065;27052.45895082048 18:35:16 INFO - PROCESS | 1670 | |2;jquery.html;304.9859218099818;362.9092726818295;371.16858237547893;371.263042859923;372.66460185832733;15350.309236084375;19168.849869007852;19776;19900.90049549752;20849.583008339825;9722;17602.415782579566;18610.255589776392;19379.806201937976;20046.498837529034;5142.305788718531;5288.338957630296;5375.516203541681;5406.297181366417;5417.783288668448;4309.655227581786;5308.097623404011;5835.824925252249;5850.180974663551;5851.64890106595;3808.5239345081864;4924.162892308316;5765.7981970631035;5810.854728631797;5826.912596311059;5983.252093488314;5984.670843103628;5994.940050599482;6002.669853158074;6022.698865056752;5300.522952934216;5480.150576660624;5577.8047768327915;5595.048841696921;5599.4120617335;23168.420789480228;23451.76548234513;23475.943582538657;23776.40558986022;23853.403664908343;2080.791920807907;2086.6765651324067;2088.822450091744;2319.489712263299;2452.7547245275327;8195.877061844078;8922.68770593026;9285.72142835716;10105.343152695052;10138.746531336701;1697.066613362658;1718.8538974187084;1725.9137043147791;1754.1317048061292;1764.3119183518438;99341.5032924838;103237.48381258121;104528;104788.95211047868;105614.47192764064;10965.50655220501;11242.55029798799;11264.66206013821;11390.886091139148;11493.712657183638;10914.181436392302;13227.669308267177;13386.598402047759;13432.19406835593;13524.93237533806;8409.873851892227;8473.661053557911;8514.70198543048;8525.701600443954;8615.353848461391;7059.682314295869;8346.497630426582;8430.40987130895;8534.573271336409;8552.273056790118;4212.7151218878535;4350.956490435118;4430.4683437987005;4448.354988526646;4474.686771925999;1542.2288855572215;1596.3375199292163;1641.458318754808;1648.4724888035714;1915.8467322614158;413.97309174903535;424.162279497989;424.7048301430476;433.3845938766959;459.41424683528766;8863.601137948808;18095.547611309823;19476.22095116208;19536.12087456068;20250.493737656678;927.679950417105;930.6044930904338;956.9617215311449;958.7603099225194;1038.4029183219527;10658.73353166177;10960.12319014477;11066.723331916606;11076.723081922855;11101.38942358178;630603;643445;672355;782879;788477;71365.64317178381;89611;96958;116671.41664291624;127489;1112.6272698646044;1124.6232512108372;1177.5466445418404;1190.1609365397373;1194.5639841457805;17784.911075445056;17890.642187156445;18176.727909011373;18700.251989920253;19246.8075319245;39718.40422393724;45512;48602;51141.97716045584;52358.47641523536;67406.01973273385;71345.28654713386;72257;72366;72367.63816180885;7307.302332054239;7452;7489.213632568501;7498.437617178624;7522.473426860067;10664.520096595827;11583;11901.107416943936;11909.464074116513;12094.334811585448;9999.900000999896;10028.843798583048;10057.949710251401;10307.433091180057;10413.895861041292;8894.42186257891;9834.459104749307;10383.844242336521;10480.318779279323;10525.9473702631;10619.36283822973;10643.733906652085;10649;10788.406637634691;10938.179636527133;7358.080239970004;7398.575163137825;7473.290037446434;7480.850382992201;7544.509606875536;9217.493037882712;10465.738356540844;10506.789864202827;10585.576576936835;10725.785484290427 18:35:16 INFO - PROCESS | 1670 | |3;mootools.html;1288.317191888299;1539.2073082362585;1705.2837808120596;1879.6240751849634;1897.6204759048194;7835.725749598765;8460.788480287996;8548.102449242833;8770.166834150754;8773.736787896358;8158.102608713037;8188;8216.342692584594;8273.172682731723;8304.667813287477;2191.539776646898;2395.323273708402;2410.493796302774;2435.914742983996;2447.0089613706477;2413.3966508372905;2421.225207933462;2457.8648174350405;2463.470353873917;2470.1601455505124;1803.4409333106714;2047.6314263432575;2281.4296425893526;2344.871032093234;2449.9020039198413;1976.6145601607693;2427.053449154831;2427.3324835670333;2448.877556122187;2462.482878595497;2449.081594402099;2453.3008092693676;2463.0394146282965;2465.9136930207355;2467.1858286765323;7088.858222835514;7342.412606991428;8551.615177316973;8604.8709269361;8640.049594544595;4572.95427045732;5328.973355133199;5470.671759694431;5493.093639549469;5522.530584900288;3004.4291584599073;3626.818659067036;3694.3165514379925;3759.0602349412648;3771.528558930134;1062.9946850265776;1063.2822844579878;1093.5024563823442;1098;1108;9904.653337133166;11449.885501144965;11984.340861252627;11987.981021613086;12010.879891201152;3673.68773654237;4488.798004089824;4856.4415092264135;4899.559039686445;4961.387549046574;9983.70211872452;10122.44326562046;10253.897461025443;10258.384496930208;10269.589216431408;5424.159255315432;5438.456154384609;5443.374011988672;5474.589405794582;5505.449455054462;4843.588294994895;4876.8780780480065;4923.803047878045;5012.674176178537;5017.648764586517;3975.204959008152;3985.860494882665;3996.4205190247253;4039.171969746195;4039.3738970459626;1215.8237055626885;1321.5308565459125;1326.6683329167709;1332.7401156774336;1338.1502745756516;1090.2422816142705;1099.4118146791427;1127.9605213817476;1253.6803115205746;1345.5357901523957;7881.921180788233;7888.329491993245;7911.208879112158;7922.326602238759;8024.117347091816;1162.1632424654235;1173.0556901694217;1174.9118816088828;1191.3745283726114;1203.6389083274983;5932.584719069624;6098.298695649968;6154.5076393888385;6201.286852012076;6282.780102696383;10116.54475548602;10720.571177152826;10841.566337346576;10847.077998370227;10856.891431085745;10407.739806504747;10458.843117353246;10576.36541807494;10699.037086662238;10700.732481688021;6910.723571057302;8231.753047408587;8267.387859367365;8300.128486508951;8325.958370208231;7789.688412463438;7870.173631768811;7886;7930.801729956797;7945.046594408708;9205.401648892801;9265.86101208469;9386.718398448058;9452.149306562442;9579.616815327308;9608.183304418922;9623.615055397706;9737.951310243403;9830.164436023018;9845.360051596623;7267.454940879349;7320.194778574459;7352.264773522605;7412.888806667796;7415.295546923034;6750.35871592198;7863.331616812635;8042.396820238622;8066.274035336848;8109.553974531457;5686.488216060575;6665.433438157811;7689.269519395649;7705.537667739954;7907.327877130509;7426.628668566658;7455.329020388191;7502.662380192795;7519.849603008019;7561;6233.345498722751;7526.849463010819;7552.962235188789;7573.507721998052;7588.27911348421;6787.423069039187;6814.488913331619;6861.416779573792;6911.861762764616;6914.239433662193;6637.340664833791;6876.381125698711;6999.195092564217;7107.182673992557;7108.751193708195 18:35:16 INFO - PROCESS | 1670 | |4;prototype.html;329.1310939120721;335.83711899728627;338.5142320769694;340.45867071356537;347.69402925425624;6742.190937087556;6838.6580670966505;6856.794296171117;6884.345987131227;6885.862282754342;6173.567850250484;6325.525585581088;6862.691178896949;6904.206016308126;6991.720331186746;5106.846794596168;5110.805746408504;5116.07910576098;5119.308893299394;5127.641065125443;4814.277858321262;5124.000819840133;5127.9230811537855;5132.640715149941;5164.354455693038;4929.309896614459;4934.185859333205;4950.603951683875;4954.331165292675;4955.851324460272;4950.455449900508;4982.302477653131;4986.700797952117;4987.62592805541;4999.250112483121;4008.5590585035625;4193.951512121969;4210.663146948237;4238.258304796648;4247.086876321575;5648.717564121777;6365.395287447685;6668.933310666928;6736;6772.322767723188;5868.677222752747;5902.026165682657;5903.468687818074;5903.881922361572;5905;7362.631868406558;7372.7050917963215;7405.296496832792;7407.629618519107;7412.666430010609;4462.174497717932;4601.7699115044115;4672.813087476497;4697.929531057037;4698.412698412699;7688.730894418669;7838.137804841463;7869.8032549186155;7876.645550950164;7896.447248692594;4778.546038126373;4802.207635740064;4803.423589169322;4807.086653535817;4808.783604737795;4017.6986725995666;4783.306420568998;4890.046440943982;4891.804327826918;4898.069366820293;5899.439553242435;5901.7639294427745;5913.704314784243;5920.348761636216;5925.881482370414;7470.813229669193;7485.214052524516;7495.138059123162;7499.700011999459;7505.812354691067;1631.4779270633283;1678.7649729037944;1694.0259350873298;1700.2178997661215;1700.481353187265;893.2050475077186;1064.7870425914848;1076.278893141597;1085.2728671789762;1086.3536195963388;6775.457963363017;6783.966080169666;6800.4219641330055;6837.931620683829;6847.726090956406;6374.84062898422;7075.726369253481;7657.617119144132;7691.961540192263;7694.307512323918;6590.143281373391;6767.898481522781;6789.287124851919;6809.93190068093;6828.760993365208;4080.959190408058;4083.693722970789;4105.548389677133;4113.218488487178;4127.174565086994;6452.741890324428;8029.718959836495;8030.478018928751;8044.356451483867;8065.153158918229;5750.856228594319;7108.289171082851;7151.569686062809;7696.807579810549;7899.407544434191;8015.278624923668;8022.558759268296;8027.1972802719265;8027.759167224993;8059;7000.949857521413;7332.156801967842;7431.962840185764;7662.233776622516;7674.6162691864065;6897.89653155193;7673.616319183907;7691.15397306307;7695.807604809701;7696.230376962259;7927.682892684459;8157.3474122071275;8183.5499047550575;8197.590120493833;8202.917970820454;4252.277112890754;4580.381648477412;4809.951900480951;4827.396575428072;4831.178699621143;7749.3413059890545;7754;7757.534547927143;7762.805929851799;7803.843923121619;7309.56450468279;7492.62536873165;7513.436492263211;7524;7533.698652054076;7471.215522370073;7471.663775130023;7493.363064139609;7506.624668766431;7510.962445187739;7274;7320.487565870338;7329.596872172082;7338.192798792235;7371.3734332582335;7179.928200717926;7380.77857664271;7399.8150046249275;7409.888851667121;7461.552306861606;5899.911501327398;6247.406496382836;6886.621235831877;7278.308560686726;7360.484766066324 18:35:16 INFO - PROCESS | 1670 | |5;yui.html;645.5706954875009;645.612632420548;674.9932500674993;718.192033961793;723.7141329174977;13169.012324075684;14932.701345973073;14991;15118.47085352013;15216.923915380421;12506.49974001039;13979.79030314546;14078.57764267071;14130.92934535326;14135.434582616708;685.9519833611649;845.9619317130713;858.9012263589705;879.65253724779;884.1335491218609;871.3160169267127;878.3719640457072;883.0198479687542;883.0992387764477;883.3904605821995;886.4459712679575;920.4569304110573;921.6405601815297;922.7739203895055;924.7133388649506;913.1097180249237;914.73015460439;914.8307563100848;919.2232563483813;920.3649481857497;672.4821887146869;674.8380388706724;681.3186813186813;682.6996121706434;683.3712984054681;15050.172240526766;15170;15177.317020734094;15200.771988420183;15220.923895380563;10237.897621023769;12838.165519241313;12859.357032148355;13184.934075329658;13235.867641323655;10078.244131690079;10120.03859633341;10488.790224195549;10493.265471417004;10969.396683182422;3537;3539.504469374264;3553.1117220694828;3559.839807208682;3569;70630.88107356736;79449;80631;82005;82086;9430.90569094314;9531.640866873066;9743.707688769347;9927.2058235341;10283.485825708685;21201.893990530258;21574.568508629738;21577.78422215789;21616.567668646538;21621.35135945924;6320.5575609706875;7317.195108538057;7412.4440666950195;7491.513051651626;7708.845823083507;4079.0822065035723;4085.4076158957378;4102.856400025985;4111.026420249288;4125.257453658371;2823.294176455886;2964.40711857625;3497.213127046445;3518.296340731864;3557.626449222846;631.8009826904511;642.1010585180691;644.8839208942342;667.3226674924955;667.366002297819;581.6277582347301;586.5718025841074;611.016263815257;628.1990462160691;628.4312697009123;6975.476839236976;8721.825563488695;9097.681581144761;9232.169104780602;9322.720318390458;529.949654782795;583.6293953339575;602.3554796367845;604.9395060493915;618.0019268880725;3796;3941.3102707026155;4058.370952502367;4099.938500922489;4152.148809494047;95271;96740;97378.513107434;97389;97410;83941;84388;84562.5771871149;84912.57543712242;86120;71216;72066.55866882633;72640;72946;73128.63435682894;8000.159983201913;8174.754757357289;8216.128806859604;8318.750437486886;8404.53775042354;42111.7894410526;47877.042459149925;48962.75518622384;50856.74571627118;51250.23124653059;64046;67251.66374168098;72779.27220727724;73217;73489;8340.541270230196;10113.039261270167;10282.434466104136;10314.948425257826;10503.470056728427;11042.668719938414;11426.428678565871;11435.714107147387;11648;12051.33717645538;10708.785824283315;10709.785804283714;10728.249022568345;10786.784264314827;10851.945740271563;10861.40262285582;10896.78206435851;10931.01620854127;11021.504032318404;11032.889671103187;10634.84047739269;10642.680719578115;10649.840252396065;10666.413347265974;10792.352458852494;8052.516848989079;8335.025632135468;8657;8836.381453298465;8902.821943561223;8862.246709029805;8909.465432074096;8914.910850891409;8934.240589549701;8957.820843582962 18:35:16 INFO - PROCESS | 1670 | __end_tp_report 18:35:16 INFO - PROCESS | 1670 | __start_cc_report 18:35:16 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,376 18:35:16 INFO - PROCESS | 1670 | __end_cc_report 18:35:16 INFO - PROCESS | 1670 | __startTimestamp1454985316597__endTimestamp 18:35:16 INFO - PROCESS | 1670 | 18:35:16 INFO - PROCESS | 1670 | ------- Summary: start ------- 18:35:16 INFO - PROCESS | 1670 | Number of tests: 6 18:35:16 INFO - PROCESS | 1670 | 18:35:16 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5782.90 Median:6037.61 stddev:631.49 (10.5%) stddev-sans-first:607.16 18:35:16 INFO - PROCESS | 1670 | Values: 3485.4 3577.4 3609.1 3624.8 3626.3 5659.0 5745.7 5778.1 5784.3 5785.3 5702.9 5715.9 5833.4 5900.9 5912.0 5187.7 5204.7 5208.0 5279.8 5309.6 5259.7 5287.9 5323.1 5325.4 5367.9 5119.1 5143.5 5239.1 5252.9 5264.3 5222.2 5238.4 5252.0 5287.3 5301.9 5093.5 5203.7 5238.7 5239.1 5254.8 5592.8 5738.6 5743.9 5755.9 5780.9 6222.1 6321.5 6336.2 6336.6 6341.8 5207.2 6209.4 6254.7 6297.2 6301.3 5904.3 5908.3 5912.6 5913.9 5988.4 5884.2 6235.0 6376.3 6384.0 6385.3 6142.5 6190.3 6220.6 6226.4 6247.7 5475.2 6273.6 6292.1 6310.1 6310.8 6137.5 6191.1 6273.8 6286.9 6315.6 6178.6 6243.7 6293.5 6300.3 6302.1 4891.6 4926.9 4960.4 4961.6 4972.4 4373.5 4415.7 4415.9 4451.9 4527.6 5849.9 5859.7 5897.8 5909.9 5958.6 6114.6 6168.7 6265.7 6327.9 6337.7 5816.6 5863.8 5867.4 5902.7 5936.1 5349.7 5390.6 5428.2 5437.2 5455.6 6253.9 6318.8 6416.4 6445.1 6450.9 6226.2 6244.3 6269.5 6278.7 6307.7 6047.9 6293.8 6297.9 6312.0 6314.0 6134.4 6135.5 6255.5 6278.0 6286.3 6241.7 6247.4 6308.1 6309.2 6313.7 6037.6 6117.0 6122.3 6200.6 6213.4 4625.2 6169.0 6202.4 6214.2 6353.6 6018.8 6065.9 6067.7 6081.5 6089.6 6038.6 6113.3 6194.8 6201.0 6224.9 5242.8 5902.6 6081.4 6091.1 6096.5 18:35:16 INFO - PROCESS | 1670 | 18:35:16 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:66905.75 Median:39328.90 stddev:139762.50 (355.4%) stddev-sans-first:140065.49 18:35:16 INFO - PROCESS | 1670 | Values: 446.0 450.1 504.8 542.3 571.0 33113.3 37811.8 38079.4 38461.4 38554.6 39834.6 40102.0 40249.0 40372.0 40376.8 8052.8 8324.4 8905.8 9281.4 9502.0 9399.0 9599.9 9613.5 9655.7 9692.6 8999.3 9599.7 9631.0 9640.0 9665.4 8033.0 9571.2 9663.1 9669.5 9682.5 9370.9 9537.0 9538.9 9545.7 9560.1 38263.3 38380.6 38797.6 38812.6 38905.2 2964.6 3150.4 3233.8 3454.5 3523.9 27765.0 27841.3 27997.7 28128.9 28219.6 2661.8 2779.5 2781.7 2834.7 2914.8 453379.2 461501.0 515326.7 516075.0 519669.0 58230.5 68052.0 68133.0 69361.0 69392.7 65766.0 66041.7 66072.0 66513.0 66537.0 16401.9 16421.9 16606.6 16634.3 16641.3 12635.7 12658.7 12781.0 12790.1 12918.9 20949.7 21287.6 21341.0 21430.4 21626.8 8548.1 9230.2 9272.3 9274.5 9288.5 941.8 942.2 1021.7 1031.2 1113.2 29585.4 29871.9 29936.3 30598.0 30787.0 1043.6 1096.5 1113.7 1143.7 1157.9 15087.9 15301.5 15427.6 15530.4 15616.8 553751.0 557567.0 560090.0 560227.0 561221.0 58603.0 59000.4 59385.0 59628.8 59805.8 1426.5 1427.8 1428.8 1455.3 1469.8 29621.3 29875.4 30128.0 30207.7 30391.7 48943.8 52204.0 52285.5 52794.7 52810.2 515216.0 517969.0 520606.0 523791.0 524947.0 28666.7 32978.8 33393.8 33439.5 33920.2 40324.0 41683.0 42098.7 42645.8 42829.8 40216.8 40964.0 41199.6 41983.2 42283.4 38302.8 38997.4 39029.6 39220.0 39336.8 38435.6 38891.4 39270.0 39321.0 40908.2 31630.5 37314.9 38275.8 38326.4 38378.6 21767.4 25051.6 26151.2 26714.5 27052.5 18:35:16 INFO - PROCESS | 1670 | 18:35:16 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:35850.66 Median:371.22 stddev:116430.87 (31364.7%) stddev-sans-first:116726.89 18:35:16 INFO - PROCESS | 1670 | Values: 305.0 362.9 371.2 371.3 372.7 15350.3 19168.8 19776.0 19900.9 20849.6 9722.0 17602.4 18610.3 19379.8 20046.5 5142.3 5288.3 5375.5 5406.3 5417.8 4309.7 5308.1 5835.8 5850.2 5851.6 3808.5 4924.2 5765.8 5810.9 5826.9 5983.3 5984.7 5994.9 6002.7 6022.7 5300.5 5480.2 5577.8 5595.0 5599.4 23168.4 23451.8 23475.9 23776.4 23853.4 2080.8 2086.7 2088.8 2319.5 2452.8 8195.9 8922.7 9285.7 10105.3 10138.7 1697.1 1718.9 1725.9 1754.1 1764.3 99341.5 103237.5 104528.0 104789.0 105614.5 10965.5 11242.6 11264.7 11390.9 11493.7 10914.2 13227.7 13386.6 13432.2 13524.9 8409.9 8473.7 8514.7 8525.7 8615.4 7059.7 8346.5 8430.4 8534.6 8552.3 4212.7 4351.0 4430.5 4448.4 4474.7 1542.2 1596.3 1641.5 1648.5 1915.8 414.0 424.2 424.7 433.4 459.4 8863.6 18095.5 19476.2 19536.1 20250.5 927.7 930.6 957.0 958.8 1038.4 10658.7 10960.1 11066.7 11076.7 11101.4 630603.0 643445.0 672355.0 782879.0 788477.0 71365.6 89611.0 96958.0 116671.4 127489.0 1112.6 1124.6 1177.5 1190.2 1194.6 17784.9 17890.6 18176.7 18700.3 19246.8 39718.4 45512.0 48602.0 51142.0 52358.5 67406.0 71345.3 72257.0 72366.0 72367.6 7307.3 7452.0 7489.2 7498.4 7522.5 10664.5 11583.0 11901.1 11909.5 12094.3 9999.9 10028.8 10057.9 10307.4 10413.9 8894.4 9834.5 10383.8 10480.3 10525.9 10619.4 10643.7 10649.0 10788.4 10938.2 7358.1 7398.6 7473.3 7480.9 7544.5 9217.5 10465.7 10506.8 10585.6 10725.8 18:35:16 INFO - PROCESS | 1670 | 18:35:16 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5933.33 Median:5431.31 stddev:3120.79 (57.5%) stddev-sans-first:3110.01 18:35:16 INFO - PROCESS | 1670 | Values: 1288.3 1539.2 1705.3 1879.6 1897.6 7835.7 8460.8 8548.1 8770.2 8773.7 8158.1 8188.0 8216.3 8273.2 8304.7 2191.5 2395.3 2410.5 2435.9 2447.0 2413.4 2421.2 2457.9 2463.5 2470.2 1803.4 2047.6 2281.4 2344.9 2449.9 1976.6 2427.1 2427.3 2448.9 2462.5 2449.1 2453.3 2463.0 2465.9 2467.2 7088.9 7342.4 8551.6 8604.9 8640.0 4573.0 5329.0 5470.7 5493.1 5522.5 3004.4 3626.8 3694.3 3759.1 3771.5 1063.0 1063.3 1093.5 1098.0 1108.0 9904.7 11449.9 11984.3 11988.0 12010.9 3673.7 4488.8 4856.4 4899.6 4961.4 9983.7 10122.4 10253.9 10258.4 10269.6 5424.2 5438.5 5443.4 5474.6 5505.4 4843.6 4876.9 4923.8 5012.7 5017.6 3975.2 3985.9 3996.4 4039.2 4039.4 1215.8 1321.5 1326.7 1332.7 1338.2 1090.2 1099.4 1128.0 1253.7 1345.5 7881.9 7888.3 7911.2 7922.3 8024.1 1162.2 1173.1 1174.9 1191.4 1203.6 5932.6 6098.3 6154.5 6201.3 6282.8 10116.5 10720.6 10841.6 10847.1 10856.9 10407.7 10458.8 10576.4 10699.0 10700.7 6910.7 8231.8 8267.4 8300.1 8326.0 7789.7 7870.2 7886.0 7930.8 7945.0 9205.4 9265.9 9386.7 9452.1 9579.6 9608.2 9623.6 9738.0 9830.2 9845.4 7267.5 7320.2 7352.3 7412.9 7415.3 6750.4 7863.3 8042.4 8066.3 8109.6 5686.5 6665.4 7689.3 7705.5 7907.3 7426.6 7455.3 7502.7 7519.8 7561.0 6233.3 7526.8 7553.0 7573.5 7588.3 6787.4 6814.5 6861.4 6911.9 6914.2 6637.3 6876.4 6999.2 7107.2 7108.8 18:35:16 INFO - PROCESS | 1670 | 18:35:16 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5991.20 Median:6786.63 stddev:1947.83 (28.7%) stddev-sans-first:1906.37 18:35:16 INFO - PROCESS | 1670 | Values: 329.1 335.8 338.5 340.5 347.7 6742.2 6838.7 6856.8 6884.3 6885.9 6173.6 6325.5 6862.7 6904.2 6991.7 5106.8 5110.8 5116.1 5119.3 5127.6 4814.3 5124.0 5127.9 5132.6 5164.4 4929.3 4934.2 4950.6 4954.3 4955.9 4950.5 4982.3 4986.7 4987.6 4999.3 4008.6 4194.0 4210.7 4238.3 4247.1 5648.7 6365.4 6668.9 6736.0 6772.3 5868.7 5902.0 5903.5 5903.9 5905.0 7362.6 7372.7 7405.3 7407.6 7412.7 4462.2 4601.8 4672.8 4697.9 4698.4 7688.7 7838.1 7869.8 7876.6 7896.4 4778.5 4802.2 4803.4 4807.1 4808.8 4017.7 4783.3 4890.0 4891.8 4898.1 5899.4 5901.8 5913.7 5920.3 5925.9 7470.8 7485.2 7495.1 7499.7 7505.8 1631.5 1678.8 1694.0 1700.2 1700.5 893.2 1064.8 1076.3 1085.3 1086.4 6775.5 6784.0 6800.4 6837.9 6847.7 6374.8 7075.7 7657.6 7692.0 7694.3 6590.1 6767.9 6789.3 6809.9 6828.8 4081.0 4083.7 4105.5 4113.2 4127.2 6452.7 8029.7 8030.5 8044.4 8065.2 5750.9 7108.3 7151.6 7696.8 7899.4 8015.3 8022.6 8027.2 8027.8 8059.0 7000.9 7332.2 7432.0 7662.2 7674.6 6897.9 7673.6 7691.2 7695.8 7696.2 7927.7 8157.3 8183.5 8197.6 8202.9 4252.3 4580.4 4810.0 4827.4 4831.2 7749.3 7754.0 7757.5 7762.8 7803.8 7309.6 7492.6 7513.4 7524.0 7533.7 7471.2 7471.7 7493.4 7506.6 7511.0 7274.0 7320.5 7329.6 7338.2 7371.4 7179.9 7380.8 7399.8 7409.9 7461.6 5899.9 6247.4 6886.6 7278.3 7360.5 18:35:16 INFO - PROCESS | 1670 | 18:35:16 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18507.84 Median:3476.18 stddev:26665.43 (767.1%) stddev-sans-first:26706.51 18:35:16 INFO - PROCESS | 1670 | Values: 645.6 645.6 675.0 718.2 723.7 13169.0 14932.7 14991.0 15118.5 15216.9 12506.5 13979.8 14078.6 14130.9 14135.4 686.0 846.0 858.9 879.7 884.1 871.3 878.4 883.0 883.1 883.4 886.4 920.5 921.6 922.8 924.7 913.1 914.7 914.8 919.2 920.4 672.5 674.8 681.3 682.7 683.4 15050.2 15170.0 15177.3 15200.8 15220.9 10237.9 12838.2 12859.4 13184.9 13235.9 10078.2 10120.0 10488.8 10493.3 10969.4 3537.0 3539.5 3553.1 3559.8 3569.0 70630.9 79449.0 80631.0 82005.0 82086.0 9430.9 9531.6 9743.7 9927.2 10283.5 21201.9 21574.6 21577.8 21616.6 21621.4 6320.6 7317.2 7412.4 7491.5 7708.8 4079.1 4085.4 4102.9 4111.0 4125.3 2823.3 2964.4 3497.2 3518.3 3557.6 631.8 642.1 644.9 667.3 667.4 581.6 586.6 611.0 628.2 628.4 6975.5 8721.8 9097.7 9232.2 9322.7 529.9 583.6 602.4 604.9 618.0 3796.0 3941.3 4058.4 4099.9 4152.1 95271.0 96740.0 97378.5 97389.0 97410.0 83941.0 84388.0 84562.6 84912.6 86120.0 71216.0 72066.6 72640.0 72946.0 73128.6 8000.2 8174.8 8216.1 8318.8 8404.5 42111.8 47877.0 48962.8 50856.7 51250.2 64046.0 67251.7 72779.3 73217.0 73489.0 8340.5 10113.0 10282.4 10314.9 10503.5 11042.7 11426.4 11435.7 11648.0 12051.3 10708.8 10709.8 10728.2 10786.8 10851.9 10861.4 10896.8 10931.0 11021.5 11032.9 10634.8 10642.7 10649.8 10666.4 10792.4 8052.5 8335.0 8657.0 8836.4 8902.8 8862.2 8909.5 8914.9 8934.2 8957.8 18:35:16 INFO - PROCESS | 1670 | -------- Summary: end -------- 18:35:16 INFO - PROCESS | 1670 | 18:35:17 INFO - TEST-INFO | 1670: exit 0 18:35:17 INFO - TEST-OK | dromaeo_css | took 1111097ms 18:35:17 INFO - TEST-START | kraken 18:35:17 INFO - operating with platform_type : mac_ 18:35:17 INFO - Initialising browser for kraken test... 18:35:17 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpzpM0gR/profile http://localhost:49283/getInfo.html) 18:35:20 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 18:35:20 INFO - PROCESS | 1684 | colorDepth:24 18:35:20 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 18:35:20 INFO - PROCESS | 1684 | __metrics 18:35:20 INFO - PROCESS | 1684 | 18:35:20 INFO - PROCESS | 1684 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 18:35:20 INFO - PROCESS | 1684 | 18:35:20 INFO - TEST-INFO | 1684: exit 0 18:35:20 INFO - Browser initialized. 18:35:20 INFO - Running cycle 1/1 for kraken test... 18:35:20 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpzpM0gR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:35:32 INFO - PROCESS | 1687 | RSS: Main: 257277952 18:35:32 INFO - PROCESS | 1687 | 18:35:35 INFO - PROCESS | 1687 | 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) 18:35:36 INFO - PROCESS | 1687 | RSS: Main: 269701120 18:35:36 INFO - PROCESS | 1687 | 18:35:38 INFO - PROCESS | 1687 | 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) 18:35:39 INFO - PROCESS | 1687 | RSS: Main: 279080960 18:35:39 INFO - PROCESS | 1687 | 18:35:42 INFO - PROCESS | 1687 | 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) 18:35:43 INFO - PROCESS | 1687 | RSS: Main: 281464832 18:35:43 INFO - PROCESS | 1687 | 18:35:45 INFO - PROCESS | 1687 | 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) 18:35:45 INFO - PROCESS | 1687 | RSS: Main: 282632192 18:35:45 INFO - PROCESS | 1687 | 18:35:47 INFO - PROCESS | 1687 | 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) 18:35:48 INFO - PROCESS | 1687 | RSS: Main: 282894336 18:35:48 INFO - PROCESS | 1687 | 18:35:51 INFO - PROCESS | 1687 | 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) 18:35:51 INFO - PROCESS | 1687 | RSS: Main: 282923008 18:35:51 INFO - PROCESS | 1687 | 18:35:54 INFO - PROCESS | 1687 | 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) 18:35:55 INFO - PROCESS | 1687 | RSS: Main: 285548544 18:35:55 INFO - PROCESS | 1687 | 18:35:58 INFO - PROCESS | 1687 | 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) 18:35:59 INFO - PROCESS | 1687 | RSS: Main: 284483584 18:35:59 INFO - PROCESS | 1687 | 18:36:00 INFO - PROCESS | 1687 | 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) 18:36:01 INFO - PROCESS | 1687 | RSS: Main: 285724672 18:36:01 INFO - PROCESS | 1687 | 18:36:03 INFO - PROCESS | 1687 | 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) 18:36:03 INFO - PROCESS | 1687 | RSS: Main: 284962816 18:36:03 INFO - PROCESS | 1687 | 18:36:05 INFO - PROCESS | 1687 | 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) 18:36:06 INFO - PROCESS | 1687 | RSS: Main: 285569024 18:36:06 INFO - PROCESS | 1687 | 18:36:08 INFO - PROCESS | 1687 | 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) 18:36:09 INFO - PROCESS | 1687 | RSS: Main: 285462528 18:36:09 INFO - PROCESS | 1687 | 18:36:12 INFO - PROCESS | 1687 | 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) 18:36:12 INFO - PROCESS | 1687 | RSS: Main: 286449664 18:36:12 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | 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) 18:36:14 INFO - PROCESS | 1687 | RSS: Main: 287436800 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | __start_tp_report 18:36:14 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 18:36:14 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 18:36:14 INFO - PROCESS | 1687 | |i|pagename|runs| 18:36:14 INFO - PROCESS | 1687 | |0;ai-astar;112;109;111;112;113;125;111;113;115;112 18:36:14 INFO - PROCESS | 1687 | |1;audio-beat-detection;146;119;142;153;134;145;140;146;169;122 18:36:14 INFO - PROCESS | 1687 | |2;audio-dft;191;195;195;198;202;205;212;192;205;201 18:36:14 INFO - PROCESS | 1687 | |3;audio-fft;59;67;74;75;121;56;58;57;58;96 18:36:14 INFO - PROCESS | 1687 | |4;audio-oscillator;80;87;113;92;121;124;139;78;79;110 18:36:14 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;85;92;86;91;86;91;89;92;79;143 18:36:14 INFO - PROCESS | 1687 | |6;imaging-darkroom;127;125;96;156;152;112;95;94;105;118 18:36:14 INFO - PROCESS | 1687 | |7;imaging-desaturate;90;95;108;142;93;129;149;92;91;145 18:36:14 INFO - PROCESS | 1687 | |8;json-parse-financial;57;59;56;55;55;57;58;63;55;55 18:36:14 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;64;65;73;71;76;71;72;100;60;99 18:36:14 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;86;84;86;87;83;85;87;85;84;85 18:36:14 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;129;140;139;136;137;123;120;128;137;128 18:36:14 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;183;165;136;142;144;140;142;139;184;139 18:36:14 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;67;68;69;66;71;92;101;98;99;68 18:36:14 INFO - PROCESS | 1687 | __end_tp_report 18:36:14 INFO - PROCESS | 1687 | __start_cc_report 18:36:14 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,913 18:36:14 INFO - PROCESS | 1687 | __end_cc_report 18:36:14 INFO - PROCESS | 1687 | __startTimestamp1454985374850__endTimestamp 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | ------- Summary: start ------- 18:36:14 INFO - PROCESS | 1687 | Number of tests: 14 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:113.30 Median:112.50 stddev:4.40 (3.9%) stddev-sans-first:4.64 18:36:14 INFO - PROCESS | 1687 | Values: 112.0 109.0 111.0 112.0 113.0 125.0 111.0 113.0 115.0 112.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:145.50 stddev:14.48 (10.0%) stddev-sans-first:15.27 18:36:14 INFO - PROCESS | 1687 | Values: 146.0 119.0 142.0 153.0 134.0 145.0 140.0 146.0 169.0 122.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:199.60 Median:201.50 stddev:6.64 (3.3%) stddev-sans-first:6.27 18:36:14 INFO - PROCESS | 1687 | Values: 191.0 195.0 195.0 198.0 202.0 205.0 212.0 192.0 205.0 201.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:72.10 Median:63.00 stddev:21.23 (33.7%) stddev-sans-first:21.98 18:36:14 INFO - PROCESS | 1687 | Values: 59.0 67.0 74.0 75.0 121.0 56.0 58.0 57.0 58.0 96.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:78.50 stddev:21.89 (27.9%) stddev-sans-first:21.68 18:36:14 INFO - PROCESS | 1687 | Values: 80.0 87.0 113.0 92.0 121.0 124.0 139.0 78.0 79.0 110.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:90.00 stddev:17.90 (19.9%) stddev-sans-first:18.72 18:36:14 INFO - PROCESS | 1687 | Values: 85.0 92.0 86.0 91.0 86.0 91.0 89.0 92.0 79.0 143.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:118.00 Median:154.00 stddev:22.42 (14.6%) stddev-sans-first:23.54 18:36:14 INFO - PROCESS | 1687 | Values: 127.0 125.0 96.0 156.0 152.0 112.0 95.0 94.0 105.0 118.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:113.40 Median:90.50 stddev:24.99 (27.6%) stddev-sans-first:25.02 18:36:14 INFO - PROCESS | 1687 | Values: 90.0 95.0 108.0 142.0 93.0 129.0 149.0 92.0 91.0 145.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:2.54 (4.5%) stddev-sans-first:2.69 18:36:14 INFO - PROCESS | 1687 | Values: 57.0 59.0 56.0 55.0 55.0 57.0 58.0 63.0 55.0 55.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:75.10 Median:71.50 stddev:13.71 (19.2%) stddev-sans-first:13.95 18:36:14 INFO - PROCESS | 1687 | Values: 64.0 65.0 73.0 71.0 76.0 71.0 72.0 100.0 60.0 99.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.50 stddev:1.32 (1.5%) stddev-sans-first:1.36 18:36:14 INFO - PROCESS | 1687 | Values: 86.0 84.0 86.0 87.0 83.0 85.0 87.0 85.0 84.0 85.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:136.50 stddev:7.02 (5.1%) stddev-sans-first:7.38 18:36:14 INFO - PROCESS | 1687 | Values: 129.0 140.0 139.0 136.0 137.0 123.0 120.0 128.0 137.0 128.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:143.00 stddev:18.72 (13.1%) stddev-sans-first:15.98 18:36:14 INFO - PROCESS | 1687 | Values: 183.0 165.0 136.0 142.0 144.0 140.0 142.0 139.0 184.0 139.0 18:36:14 INFO - PROCESS | 1687 | 18:36:14 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.90 Median:70.00 stddev:15.37 (22.0%) stddev-sans-first:15.57 18:36:14 INFO - PROCESS | 1687 | Values: 67.0 68.0 69.0 66.0 71.0 92.0 101.0 98.0 99.0 68.0 18:36:14 INFO - PROCESS | 1687 | -------- Summary: end -------- 18:36:14 INFO - PROCESS | 1687 | 18:36:15 INFO - TEST-INFO | 1687: exit 0 18:36:15 INFO - TEST-OK | kraken | took 58634ms 18:36:15 INFO - SUITE-END | took 1169s 18:36:16 INFO - Completed test suite (00:19:29) 18:36:16 INFO - Working with test: dromaeo_css 18:36:16 INFO - Generating results file: dromaeo_css 18:36:16 INFO - Working with test: kraken 18:36:16 INFO - Generating results file: kraken 18:36:16 INFO - javascript benchmark 18:36:16 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:36:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 18:36:16 INFO - process_Request line: dromaeo_css 7507.81 graph.html#tests=[[72,64,61]] 18:36:16 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:36:16 INFO - process_Request line: kraken 1534.00 graph.html#tests=[[232,64,61]] 18:36:16 INFO - RETURN: dromaeo_css: 7507.81 18:36:16 INFO - RETURN: kraken: 1534.00 18:36:16 INFO - javascript benchmark 18:36:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3485.4074807282764, 3577.40972739498, 3609.133807886108, 3624.8006359650226, 3626.2747450509887, 5659.0, 5745.6839873806975, 5778.075507918734, 5784.2769653793275, 5785.3346865110525, 5702.914456283159, 5715.914261286084, 5833.416658334165, 5900.88198236035, 5912.024515954862, 5187.6628019178725, 5204.687718736869, 5208.0365132450615, 5279.815206467774, 5309.62832601718, 5259.684418934857, 5287.947120528784, 5323.121684922003, 5325.440828712987, 5367.946320536784, 5119.052975199581, 5143.485651434864, 5239.083160446907, 5252.894942101137, 5264.315638966948, 5222.2427747976335, 5238.371395432534, 5251.973740131275, 5287.312649355559, 5301.920471192935, 5093.5415812576675, 5203.687778733288, 5238.659487133325, 5239.109351410231, 5254.789808407659, 5592.832215033555, 5738.598298119134, 5743.913841292384, 5755.856103597402, 5780.8843823123725, 6222.097795819626, 6321.494280457552, 6336.2396512418345, 6336.619802811846, 6341.778037768656, 5207.244949482341, 6209.441150296449, 6254.687265636746, 6297.244330680348, 6301.275353334334, 5904.254521647455, 5908.3205431375945, 5912.556558258148, 5913.9112913306335, 5988.371221021774, 5884.176215329857, 6235.033569796688, 6376.29860715321, 6383.96808015957, 6385.329540398284, 6142.5294708490455, 6190.288116866528, 6220.564560480723, 6226.40849119333, 6247.656378899204, 5475.151351540518, 6273.560850740404, 6292.119103325538, 6310.085037669604, 6310.810675679737, 6137.4689182037, 6191.102290167991, 6273.811785646347, 6286.9056964145575, 6315.621062736251, 6178.62928224308, 6243.687815609202, 6293.527985401113, 6300.30696623371, 6302.149209856702, 4891.559759621651, 4926.852194434173, 4960.379952505937, 4961.603071754251, 4972.378452693413, 4373.453318335208, 4415.66882483815, 4415.889602759957, 4451.888702782457, 4527.61515271199, 5849.941500585025, 5859.677717725566, 5897.823065307962, 5909.881802363929, 5958.612690175125, 6114.601521188728, 6168.691565421711, 6265.686626030784, 6327.873442531123, 6337.683115844282, 5816.592838501264, 5863.765449382062, 5867.3839246879315, 5902.704864756745, 5936.079907614327, 5349.732513374393, 5390.568754499631, 5428.185772134211, 5437.184422336682, 5455.618106732491, 6253.937460625336, 6318.842028949313, 6416.390442907917, 6445.129907462432, 6450.870982580416, 6226.1905952225925, 6244.281907580505, 6269.467095296951, 6278.686065696788, 6307.684615769285, 6047.879042419215, 6293.842653933688, 6297.905531417124, 6311.96844015777, 6313.96843015782, 6134.375358695336, 6135.478484328882, 6255.468285195628, 6278.0, 6286.308506064421, 6241.719122639583, 6247.406496382836, 6308.116863639186, 6309.211348581427, 6313.6843157841, 6037.607555508878, 6116.960116780069, 6122.326544080059, 6200.56596038273, 6213.37866213375, 4625.236835922035, 6168.9691551541955, 6202.41077097675, 6214.161088253028, 6353.555251132377, 6018.849528761816, 6065.909011364744, 6067.696615169312, 6081.483073938588, 6089.573729839046, 6038.607490513103, 6113.263474096151, 6194.845128871814, 6201.0, 6224.937750622617, 5242.820365417903, 5902.61632993854, 6081.422264884829, 6091.0558863376245, 6096.512279017757], "unit": "score", "name": "dojo.html", "value": 5745.728363847542}, {"lowerIsBetter": false, "replicates": [445.95986361227483, 450.0512779664055, 504.81321910892973, 542.2841848759634, 570.9628874123182, 33113.33773324538, 37811.81094094529, 38079.42880856783, 38461.42307865384, 38554.61445385549, 39834.60165398345, 40102.0, 40248.993775155635, 40371.990700232505, 40376.79811600938, 8052.758417247463, 8324.417290789646, 8905.753194552768, 9281.350305478636, 9502.049795020477, 9398.953005234964, 9599.856002159973, 9613.471259080748, 9655.710328690151, 9692.612295508172, 8999.325050621197, 9599.712008639752, 9630.951845240765, 9639.987801280835, 9665.371750836173, 8032.959835200787, 9571.234301255883, 9663.130318271355, 9669.468179250138, 9682.46746428946, 9370.906290937071, 9536.952315238379, 9538.904610953941, 9545.713628591153, 9560.139587437094, 38263.32156749029, 38380.61619383798, 38797.61202387968, 38812.611873881186, 38905.221895562216, 2964.5553167024905, 3150.401423729484, 3233.757468189895, 3454.481827725836, 3523.8766643167364, 27765.0, 27841.303967400978, 27997.72002279992, 28128.859355703295, 28219.57670634942, 2661.828795330068, 2779.471900338949, 2781.749642532182, 2834.6740124885696, 2914.7959642825012, 453379.1993120106, 461500.9999999966, 515326.6934661286, 516075.0, 519669.0, 58230.54423639443, 68052.0, 68133.0, 69361.0, 69392.6530367355, 65766.0, 66041.6697916517, 66072.0, 66513.0, 66537.0, 16401.93387429813, 16421.91789041047, 16606.584835379213, 16634.33462661504, 16641.33434662624, 12635.74728505443, 12658.683532911567, 12781.041421893395, 12790.10469267161, 12918.870811291954, 20949.743015419124, 21287.61630494013, 21341.0, 21430.357089287347, 21626.810525421253, 8548.102449242864, 9230.215431688383, 9272.30457715674, 9274.489903055397, 9288.489133097744, 941.764558860285, 942.2132519346422, 1021.7292417509366, 1031.2111234905303, 1113.2207454781685, 29585.408291834043, 29871.850640747092, 29936.25159371033, 30598.0, 30787.0, 1043.6034306963456, 1096.4846522134585, 1113.6714669172452, 1143.6969203161002, 1157.866845312783, 15087.924560377129, 15301.540953771182, 15427.641107082536, 15530.378784848706, 15616.76574851378, 553751.0, 557567.0, 560090.0, 560227.0, 561221.0, 58603.0, 59000.40999589949, 59385.0, 59628.80742385128, 59805.80388392295, 1426.4793350427226, 1427.7786943023848, 1428.8212224914487, 1455.272363818091, 1469.7868809022846, 29621.25946851346, 29875.402491949604, 30128.0, 30207.69792302049, 30391.720620953958, 48943.75528122479, 52204.0, 52285.47714522806, 52794.736026319624, 52810.207846883095, 515216.0, 517969.0, 520606.0, 523791.0, 524947.0, 28666.713332866406, 32978.83510582432, 33393.83303083469, 33439.49840752439, 33920.15199620029, 40324.0, 41682.95792605209, 42098.73703788891, 42645.78677106595, 42829.78585107055, 40216.7989160064, 40963.97590060272, 41199.58800412077, 41983.160336793706, 42283.36574951317, 38302.808485957394, 38997.41503877387, 39029.609703903734, 39220.0, 39336.803315983234, 38435.6156438432, 38891.416628751154, 39270.01824954399, 39321.0, 40908.1818363637, 31630.525542116426, 37314.91707185432, 38275.80862095672, 38326.425103624024, 38378.61621383751, 21767.38888250523, 25051.57560362043, 26151.215463536126, 26714.465710686065, 27052.45895082048], "unit": "score", "name": "ext.html", "value": 20062.821275810875}, {"lowerIsBetter": false, "replicates": [304.9859218099818, 362.9092726818295, 371.16858237547893, 371.263042859923, 372.66460185832733, 15350.309236084375, 19168.849869007852, 19776.0, 19900.90049549752, 20849.583008339825, 9722.0, 17602.415782579566, 18610.255589776392, 19379.806201937976, 20046.498837529034, 5142.305788718531, 5288.338957630296, 5375.516203541681, 5406.297181366417, 5417.783288668448, 4309.655227581786, 5308.097623404011, 5835.824925252249, 5850.180974663551, 5851.64890106595, 3808.5239345081864, 4924.162892308316, 5765.7981970631035, 5810.854728631797, 5826.912596311059, 5983.252093488314, 5984.670843103628, 5994.940050599482, 6002.669853158074, 6022.698865056752, 5300.522952934216, 5480.150576660624, 5577.8047768327915, 5595.048841696921, 5599.4120617335, 23168.420789480228, 23451.76548234513, 23475.943582538657, 23776.40558986022, 23853.403664908343, 2080.791920807907, 2086.6765651324067, 2088.822450091744, 2319.489712263299, 2452.7547245275327, 8195.877061844078, 8922.68770593026, 9285.72142835716, 10105.343152695052, 10138.746531336701, 1697.066613362658, 1718.8538974187084, 1725.9137043147791, 1754.1317048061292, 1764.3119183518438, 99341.5032924838, 103237.48381258121, 104528.0, 104788.95211047868, 105614.47192764064, 10965.50655220501, 11242.55029798799, 11264.66206013821, 11390.886091139148, 11493.712657183638, 10914.181436392302, 13227.669308267177, 13386.598402047759, 13432.19406835593, 13524.93237533806, 8409.873851892227, 8473.661053557911, 8514.70198543048, 8525.701600443954, 8615.353848461391, 7059.682314295869, 8346.497630426582, 8430.40987130895, 8534.573271336409, 8552.273056790118, 4212.7151218878535, 4350.956490435118, 4430.4683437987005, 4448.354988526646, 4474.686771925999, 1542.2288855572215, 1596.3375199292163, 1641.458318754808, 1648.4724888035714, 1915.8467322614158, 413.97309174903535, 424.162279497989, 424.7048301430476, 433.3845938766959, 459.41424683528766, 8863.601137948808, 18095.547611309823, 19476.22095116208, 19536.12087456068, 20250.493737656678, 927.679950417105, 930.6044930904338, 956.9617215311449, 958.7603099225194, 1038.4029183219527, 10658.73353166177, 10960.12319014477, 11066.723331916606, 11076.723081922855, 11101.38942358178, 630603.0, 643445.0, 672355.0, 782879.0, 788477.0, 71365.64317178381, 89611.0, 96958.0, 116671.41664291624, 127489.0, 1112.6272698646044, 1124.6232512108372, 1177.5466445418404, 1190.1609365397373, 1194.5639841457805, 17784.911075445056, 17890.642187156445, 18176.727909011373, 18700.251989920253, 19246.8075319245, 39718.40422393724, 45512.0, 48602.0, 51141.97716045584, 52358.47641523536, 67406.01973273385, 71345.28654713386, 72257.0, 72366.0, 72367.63816180885, 7307.302332054239, 7452.0, 7489.213632568501, 7498.437617178624, 7522.473426860067, 10664.520096595827, 11583.0, 11901.107416943936, 11909.464074116513, 12094.334811585448, 9999.900000999896, 10028.843798583048, 10057.949710251401, 10307.433091180057, 10413.895861041292, 8894.42186257891, 9834.459104749307, 10383.844242336521, 10480.318779279323, 10525.9473702631, 10619.36283822973, 10643.733906652085, 10649.0, 10788.406637634691, 10938.179636527133, 7358.080239970004, 7398.575163137825, 7473.290037446434, 7480.850382992201, 7544.509606875536, 9217.493037882712, 10465.738356540844, 10506.789864202827, 10585.576576936835, 10725.785484290427], "unit": "score", "name": "jquery.html", "value": 8819.625388892357}, {"lowerIsBetter": false, "replicates": [1288.317191888299, 1539.2073082362585, 1705.2837808120596, 1879.6240751849634, 1897.6204759048194, 7835.725749598765, 8460.788480287996, 8548.102449242833, 8770.166834150754, 8773.736787896358, 8158.102608713037, 8188.0, 8216.342692584594, 8273.172682731723, 8304.667813287477, 2191.539776646898, 2395.323273708402, 2410.493796302774, 2435.914742983996, 2447.0089613706477, 2413.3966508372905, 2421.225207933462, 2457.8648174350405, 2463.470353873917, 2470.1601455505124, 1803.4409333106714, 2047.6314263432575, 2281.4296425893526, 2344.871032093234, 2449.9020039198413, 1976.6145601607693, 2427.053449154831, 2427.3324835670333, 2448.877556122187, 2462.482878595497, 2449.081594402099, 2453.3008092693676, 2463.0394146282965, 2465.9136930207355, 2467.1858286765323, 7088.858222835514, 7342.412606991428, 8551.615177316973, 8604.8709269361, 8640.049594544595, 4572.95427045732, 5328.973355133199, 5470.671759694431, 5493.093639549469, 5522.530584900288, 3004.4291584599073, 3626.818659067036, 3694.3165514379925, 3759.0602349412648, 3771.528558930134, 1062.9946850265776, 1063.2822844579878, 1093.5024563823442, 1098.0, 1108.0, 9904.653337133166, 11449.885501144965, 11984.340861252627, 11987.981021613086, 12010.879891201152, 3673.68773654237, 4488.798004089824, 4856.4415092264135, 4899.559039686445, 4961.387549046574, 9983.70211872452, 10122.44326562046, 10253.897461025443, 10258.384496930208, 10269.589216431408, 5424.159255315432, 5438.456154384609, 5443.374011988672, 5474.589405794582, 5505.449455054462, 4843.588294994895, 4876.8780780480065, 4923.803047878045, 5012.674176178537, 5017.648764586517, 3975.204959008152, 3985.860494882665, 3996.4205190247253, 4039.171969746195, 4039.3738970459626, 1215.8237055626885, 1321.5308565459125, 1326.6683329167709, 1332.7401156774336, 1338.1502745756516, 1090.2422816142705, 1099.4118146791427, 1127.9605213817476, 1253.6803115205746, 1345.5357901523957, 7881.921180788233, 7888.329491993245, 7911.208879112158, 7922.326602238759, 8024.117347091816, 1162.1632424654235, 1173.0556901694217, 1174.9118816088828, 1191.3745283726114, 1203.6389083274983, 5932.584719069624, 6098.298695649968, 6154.5076393888385, 6201.286852012076, 6282.780102696383, 10116.54475548602, 10720.571177152826, 10841.566337346576, 10847.077998370227, 10856.891431085745, 10407.739806504747, 10458.843117353246, 10576.36541807494, 10699.037086662238, 10700.732481688021, 6910.723571057302, 8231.753047408587, 8267.387859367365, 8300.128486508951, 8325.958370208231, 7789.688412463438, 7870.173631768811, 7886.0, 7930.801729956797, 7945.046594408708, 9205.401648892801, 9265.86101208469, 9386.718398448058, 9452.149306562442, 9579.616815327308, 9608.183304418922, 9623.615055397706, 9737.951310243403, 9830.164436023018, 9845.360051596623, 7267.454940879349, 7320.194778574459, 7352.264773522605, 7412.888806667796, 7415.295546923034, 6750.35871592198, 7863.331616812635, 8042.396820238622, 8066.274035336848, 8109.553974531457, 5686.488216060575, 6665.433438157811, 7689.269519395649, 7705.537667739954, 7907.327877130509, 7426.628668566658, 7455.329020388191, 7502.662380192795, 7519.849603008019, 7561.0, 6233.345498722751, 7526.849463010819, 7552.962235188789, 7573.507721998052, 7588.27911348421, 6787.423069039187, 6814.488913331619, 6861.416779573792, 6911.861762764616, 6914.239433662193, 6637.340664833791, 6876.381125698711, 6999.195092564217, 7107.182673992557, 7108.751193708195], "unit": "score", "name": "mootools.html", "value": 4852.388726699248}, {"lowerIsBetter": false, "replicates": [329.1310939120721, 335.83711899728627, 338.5142320769694, 340.45867071356537, 347.69402925425624, 6742.190937087556, 6838.6580670966505, 6856.794296171117, 6884.345987131227, 6885.862282754342, 6173.567850250484, 6325.525585581088, 6862.691178896949, 6904.206016308126, 6991.720331186746, 5106.846794596168, 5110.805746408504, 5116.07910576098, 5119.308893299394, 5127.641065125443, 4814.277858321262, 5124.000819840133, 5127.9230811537855, 5132.640715149941, 5164.354455693038, 4929.309896614459, 4934.185859333205, 4950.603951683875, 4954.331165292675, 4955.851324460272, 4950.455449900508, 4982.302477653131, 4986.700797952117, 4987.62592805541, 4999.250112483121, 4008.5590585035625, 4193.951512121969, 4210.663146948237, 4238.258304796648, 4247.086876321575, 5648.717564121777, 6365.395287447685, 6668.933310666928, 6736.0, 6772.322767723188, 5868.677222752747, 5902.026165682657, 5903.468687818074, 5903.881922361572, 5905.0, 7362.631868406558, 7372.7050917963215, 7405.296496832792, 7407.629618519107, 7412.666430010609, 4462.174497717932, 4601.7699115044115, 4672.813087476497, 4697.929531057037, 4698.412698412699, 7688.730894418669, 7838.137804841463, 7869.8032549186155, 7876.645550950164, 7896.447248692594, 4778.546038126373, 4802.207635740064, 4803.423589169322, 4807.086653535817, 4808.783604737795, 4017.6986725995666, 4783.306420568998, 4890.046440943982, 4891.804327826918, 4898.069366820293, 5899.439553242435, 5901.7639294427745, 5913.704314784243, 5920.348761636216, 5925.881482370414, 7470.813229669193, 7485.214052524516, 7495.138059123162, 7499.700011999459, 7505.812354691067, 1631.4779270633283, 1678.7649729037944, 1694.0259350873298, 1700.2178997661215, 1700.481353187265, 893.2050475077186, 1064.7870425914848, 1076.278893141597, 1085.2728671789762, 1086.3536195963388, 6775.457963363017, 6783.966080169666, 6800.4219641330055, 6837.931620683829, 6847.726090956406, 6374.84062898422, 7075.726369253481, 7657.617119144132, 7691.961540192263, 7694.307512323918, 6590.143281373391, 6767.898481522781, 6789.287124851919, 6809.93190068093, 6828.760993365208, 4080.959190408058, 4083.693722970789, 4105.548389677133, 4113.218488487178, 4127.174565086994, 6452.741890324428, 8029.718959836495, 8030.478018928751, 8044.356451483867, 8065.153158918229, 5750.856228594319, 7108.289171082851, 7151.569686062809, 7696.807579810549, 7899.407544434191, 8015.278624923668, 8022.558759268296, 8027.1972802719265, 8027.759167224993, 8059.0, 7000.949857521413, 7332.156801967842, 7431.962840185764, 7662.233776622516, 7674.6162691864065, 6897.89653155193, 7673.616319183907, 7691.15397306307, 7695.807604809701, 7696.230376962259, 7927.682892684459, 8157.3474122071275, 8183.5499047550575, 8197.590120493833, 8202.917970820454, 4252.277112890754, 4580.381648477412, 4809.951900480951, 4827.396575428072, 4831.178699621143, 7749.3413059890545, 7754.0, 7757.534547927143, 7762.805929851799, 7803.843923121619, 7309.56450468279, 7492.62536873165, 7513.436492263211, 7524.0, 7533.698652054076, 7471.215522370073, 7471.663775130023, 7493.363064139609, 7506.624668766431, 7510.962445187739, 7274.0, 7320.487565870338, 7329.596872172082, 7338.192798792235, 7371.3734332582335, 7179.928200717926, 7380.77857664271, 7399.8150046249275, 7409.888851667121, 7461.552306861606, 5899.911501327398, 6247.406496382836, 6886.621235831877, 7278.308560686726, 7360.484766066324], "unit": "score", "name": "prototype.html", "value": 5334.164025987304}, {"lowerIsBetter": false, "replicates": [645.5706954875009, 645.612632420548, 674.9932500674993, 718.192033961793, 723.7141329174977, 13169.012324075684, 14932.701345973073, 14991.0, 15118.47085352013, 15216.923915380421, 12506.49974001039, 13979.79030314546, 14078.57764267071, 14130.92934535326, 14135.434582616708, 685.9519833611649, 845.9619317130713, 858.9012263589705, 879.65253724779, 884.1335491218609, 871.3160169267127, 878.3719640457072, 883.0198479687542, 883.0992387764477, 883.3904605821995, 886.4459712679575, 920.4569304110573, 921.6405601815297, 922.7739203895055, 924.7133388649506, 913.1097180249237, 914.73015460439, 914.8307563100848, 919.2232563483813, 920.3649481857497, 672.4821887146869, 674.8380388706724, 681.3186813186813, 682.6996121706434, 683.3712984054681, 15050.172240526766, 15170.0, 15177.317020734094, 15200.771988420183, 15220.923895380563, 10237.897621023769, 12838.165519241313, 12859.357032148355, 13184.934075329658, 13235.867641323655, 10078.244131690079, 10120.03859633341, 10488.790224195549, 10493.265471417004, 10969.396683182422, 3537.0, 3539.504469374264, 3553.1117220694828, 3559.839807208682, 3569.0, 70630.88107356736, 79449.0, 80631.0, 82005.0, 82086.0, 9430.90569094314, 9531.640866873066, 9743.707688769347, 9927.2058235341, 10283.485825708685, 21201.893990530258, 21574.568508629738, 21577.78422215789, 21616.567668646538, 21621.35135945924, 6320.5575609706875, 7317.195108538057, 7412.4440666950195, 7491.513051651626, 7708.845823083507, 4079.0822065035723, 4085.4076158957378, 4102.856400025985, 4111.026420249288, 4125.257453658371, 2823.294176455886, 2964.40711857625, 3497.213127046445, 3518.296340731864, 3557.626449222846, 631.8009826904511, 642.1010585180691, 644.8839208942342, 667.3226674924955, 667.366002297819, 581.6277582347301, 586.5718025841074, 611.016263815257, 628.1990462160691, 628.4312697009123, 6975.476839236976, 8721.825563488695, 9097.681581144761, 9232.169104780602, 9322.720318390458, 529.949654782795, 583.6293953339575, 602.3554796367845, 604.9395060493915, 618.0019268880725, 3796.0, 3941.3102707026155, 4058.370952502367, 4099.938500922489, 4152.148809494047, 95271.0, 96740.0, 97378.513107434, 97389.0, 97410.0, 83941.0, 84388.0, 84562.5771871149, 84912.57543712242, 86120.0, 71216.0, 72066.55866882633, 72640.0, 72946.0, 73128.63435682894, 8000.159983201913, 8174.754757357289, 8216.128806859604, 8318.750437486886, 8404.53775042354, 42111.7894410526, 47877.042459149925, 48962.75518622384, 50856.74571627118, 51250.23124653059, 64046.0, 67251.66374168098, 72779.27220727724, 73217.0, 73489.0, 8340.541270230196, 10113.039261270167, 10282.434466104136, 10314.948425257826, 10503.470056728427, 11042.668719938414, 11426.428678565871, 11435.714107147387, 11648.0, 12051.33717645538, 10708.785824283315, 10709.785804283714, 10728.249022568345, 10786.784264314827, 10851.945740271563, 10861.40262285582, 10896.78206435851, 10931.01620854127, 11021.504032318404, 11032.889671103187, 10634.84047739269, 10642.680719578115, 10649.840252396065, 10666.413347265974, 10792.352458852494, 8052.516848989079, 8335.025632135468, 8657.0, 8836.381453298465, 8902.821943561223, 8862.246709029805, 8909.465432074096, 8914.910850891409, 8934.240589549701, 8957.820843582962], "unit": "score", "name": "yui.html", "value": 6805.1055071108}], "name": "dromaeo_css", "value": 7507.8057835207965}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 111.0, 112.0, 113.0, 125.0, 111.0, 113.0, 115.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [146.0, 119.0, 142.0, 153.0, 134.0, 145.0, 140.0, 146.0, 169.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 141.6}, {"lowerIsBetter": true, "replicates": [191.0, 195.0, 195.0, 198.0, 202.0, 205.0, 212.0, 192.0, 205.0, 201.0], "unit": "score", "name": "audio-dft", "value": 199.6}, {"lowerIsBetter": true, "replicates": [59.0, 67.0, 74.0, 75.0, 121.0, 56.0, 58.0, 57.0, 58.0, 96.0], "unit": "score", "name": "audio-fft", "value": 72.1}, {"lowerIsBetter": true, "replicates": [80.0, 87.0, 113.0, 92.0, 121.0, 124.0, 139.0, 78.0, 79.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 102.3}, {"lowerIsBetter": true, "replicates": [85.0, 92.0, 86.0, 91.0, 86.0, 91.0, 89.0, 92.0, 79.0, 143.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.4}, {"lowerIsBetter": true, "replicates": [127.0, 125.0, 96.0, 156.0, 152.0, 112.0, 95.0, 94.0, 105.0, 118.0], "unit": "score", "name": "imaging-darkroom", "value": 118.0}, {"lowerIsBetter": true, "replicates": [90.0, 95.0, 108.0, 142.0, 93.0, 129.0, 149.0, 92.0, 91.0, 145.0], "unit": "score", "name": "imaging-desaturate", "value": 113.4}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 56.0, 55.0, 55.0, 57.0, 58.0, 63.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 73.0, 71.0, 76.0, 71.0, 72.0, 100.0, 60.0, 99.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 75.1}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 86.0, 87.0, 83.0, 85.0, 87.0, 85.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [129.0, 140.0, 139.0, 136.0, 137.0, 123.0, 120.0, 128.0, 137.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.7}, {"lowerIsBetter": true, "replicates": [183.0, 165.0, 136.0, 142.0, 144.0, 140.0, 142.0, 139.0, 184.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 66.0, 71.0, 92.0, 101.0, 98.0, 99.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 79.9}], "name": "kraken", "value": 1534.0000000000002}]} 18:36:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1534.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7507.81"}}} 18:36:16 INFO - Return code: 0 18:36:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:36:16 INFO - # TBPL SUCCESS # 18:36:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:36:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:36:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:36:16 INFO - 2016-02-08 18:36:16.571 screenresolution[1692:10623] starting screenresolution argv=screenresolution get 18:36:16 INFO - 2016-02-08 18:36:16.574 screenresolution[1692:10623] Display 0: 1600x1200x32@60 18:36:16 INFO - 2016-02-08 18:36:16.579 screenresolution[1693:10626] starting screenresolution argv=screenresolution list 18:36:16 INFO - Available Modes on Display 0 18:36:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:36:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:36:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:36:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:36:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:36:16 INFO - Intel Iris: 18:36:16 INFO - Chipset Model: Intel Iris 18:36:16 INFO - Type: GPU 18:36:16 INFO - Bus: Built-In 18:36:16 INFO - VRAM (Dynamic, Max): 1536 MB 18:36:16 INFO - Vendor: Intel (0x8086) 18:36:16 INFO - Device ID: 0x0a2e 18:36:16 INFO - Revision ID: 0x0009 18:36:16 INFO - Displays: 18:36:16 INFO - Display: 18:36:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:36:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:36:16 INFO - Display Serial Number: 1600x1200 60 18:36:16 INFO - Main Display: Yes 18:36:16 INFO - Mirror: Off 18:36:16 INFO - Online: Yes 18:36:16 INFO - Rotation: Supported 18:36:16 INFO - Return code: 0 18:36:16 INFO - Running post-action listener: _resource_record_post_action 18:36:16 INFO - Running post-run listener: _resource_record_post_run 18:36:17 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 39413248; Write bytes: 713420800; Read time: 453; Write time: 1970 18:36:17 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 406505984; Write bytes: 408000512; Read time: 30476; Write time: 750 18:36:17 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 37430784; Write bytes: 303921152; Read time: 429; Write time: 1217 18:36:17 INFO - Running post-run listener: _upload_blobber_files 18:36:17 INFO - Blob upload gear active. 18:36:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:36:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:36:18 INFO - (blobuploader) - INFO - Open directory for files ... 18:36:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:36:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:36:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:36:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:36:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:36:19 INFO - (blobuploader) - INFO - Done attempting. 18:36:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:36:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:36:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:36:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:36:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:36:20 INFO - (blobuploader) - INFO - Done attempting. 18:36:20 INFO - (blobuploader) - INFO - Iteration through files over. 18:36:20 INFO - Return code: 0 18:36:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:36:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:36:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d82e63569b3c9437e17bd8a132083c74211fac930fc92aa4c9af61563bcc81b79c5941535ca71ae372e3aaf77650e4e41b0740c1ddc8b8ec6315b8cf97eda613", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a80799af626a410c8db67bff206abeadc23915bdae516e77707055d99190ce26fd063eaf5e7c41762eb576cc2126c108d5b42fc8982b10510f637916543017a"} 18:36:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:36:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:36:20 INFO - Contents: 18:36:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d82e63569b3c9437e17bd8a132083c74211fac930fc92aa4c9af61563bcc81b79c5941535ca71ae372e3aaf77650e4e41b0740c1ddc8b8ec6315b8cf97eda613", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a80799af626a410c8db67bff206abeadc23915bdae516e77707055d99190ce26fd063eaf5e7c41762eb576cc2126c108d5b42fc8982b10510f637916543017a"} 18:36:20 INFO - Running post-run listener: copy_logs_to_upload_dir 18:36:20 INFO - Copying logs to upload dir... 18:36:20 INFO - mkdir: /builds/slave/test/build/upload/logs 18:36:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.858507 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-08 18:36:20.205531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 18:36:20.209639) ========= 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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d82e63569b3c9437e17bd8a132083c74211fac930fc92aa4c9af61563bcc81b79c5941535ca71ae372e3aaf77650e4e41b0740c1ddc8b8ec6315b8cf97eda613", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a80799af626a410c8db67bff206abeadc23915bdae516e77707055d99190ce26fd063eaf5e7c41762eb576cc2126c108d5b42fc8982b10510f637916543017a"} build_url:https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010996 build_url: 'https://queue.taskcluster.net/v1/task/ESlHi4gkTA-QXwP3oZgxpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d82e63569b3c9437e17bd8a132083c74211fac930fc92aa4c9af61563bcc81b79c5941535ca71ae372e3aaf77650e4e41b0740c1ddc8b8ec6315b8cf97eda613", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a80799af626a410c8db67bff206abeadc23915bdae516e77707055d99190ce26fd063eaf5e7c41762eb576cc2126c108d5b42fc8982b10510f637916543017a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 18:36:20.237018) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 18:36:20.237402) ========= 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.3fwBtgwG5x/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.ZP7u6tqDch/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.005041 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 18:36:20.286231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 18:36:20.286585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 18:36:20.286964) ========= ========= Total master_lag: 2.93 =========