builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0085 starttime: 1456953512.54 results: success (0) buildid: 20160302121421 builduid: cf20708f98e04bfe8e2335a5f3552395 revision: c36859eaec38c5f0aeb886b97be0950f7a0dd259 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:32.539760) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:32.540199) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:32.540490) ========= 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.wBlQrHxtOp/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.35UAgjIjVu/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005758 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:32.563656) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:32.567006) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:32.586167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:32.586507) ========= 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.wBlQrHxtOp/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.35UAgjIjVu/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005491 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:32.762706) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:32.769039) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:32.769415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-02 13:18:32.769691) ========= 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.wBlQrHxtOp/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.35UAgjIjVu/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-02 13:18:32-- 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-03-02 13:18:32 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151255 ========= master_lag: 5.65 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-02 13:18:38.569184) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:38.569564) ========= 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.wBlQrHxtOp/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.35UAgjIjVu/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.027366 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:38.619501) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 13:18:38.622926) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c36859eaec38c5f0aeb886b97be0950f7a0dd259 --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 c36859eaec38c5f0aeb886b97be0950f7a0dd259 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wBlQrHxtOp/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.35UAgjIjVu/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-02 13:18:38,702 truncating revision to first 12 chars 2016-03-02 13:18:38,702 Setting DEBUG logging. 2016-03-02 13:18:38,702 attempt 1/10 2016-03-02 13:18:38,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c36859eaec38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 13:18:39,710 unpacking tar archive at: fx-team-c36859eaec38/testing/mozharness/ program finished with exit code 0 elapsedTime=1.257922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 13:18:39.899369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:39.899751) ========= echo c36859eaec38c5f0aeb886b97be0950f7a0dd259 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c36859eaec38c5f0aeb886b97be0950f7a0dd259'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wBlQrHxtOp/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.35UAgjIjVu/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 c36859eaec38c5f0aeb886b97be0950f7a0dd259 program finished with exit code 0 elapsedTime=0.005486 script_repo_revision: 'c36859eaec38c5f0aeb886b97be0950f7a0dd259' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:39.955710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:39.956063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 13:18:39.972785) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-02 13:18:39.973178) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.wBlQrHxtOp/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.35UAgjIjVu/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:18:40 INFO - MultiFileLogger online at 20160302 13:18:40 in /builds/slave/test 13:18:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:18:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:18:40 INFO - {'append_to_log': False, 13:18:40 INFO - 'base_work_dir': '/builds/slave/test', 13:18:40 INFO - 'blob_upload_branch': 'Fx-Team', 13:18:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:18:40 INFO - 'branch': 'Fx-Team', 13:18:40 INFO - 'buildbot_json_path': 'buildprops.json', 13:18:40 INFO - 'config_files': ('talos/mac_config.py',), 13:18:40 INFO - 'default_actions': ('clobber', 13:18:40 INFO - 'read-buildbot-config', 13:18:40 INFO - 'download-and-extract', 13:18:40 INFO - 'populate-webroot', 13:18:40 INFO - 'create-virtualenv', 13:18:40 INFO - 'install', 13:18:40 INFO - 'run-tests'), 13:18:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:18:40 INFO - 'download_minidump_stackwalk': True, 13:18:40 INFO - 'download_symbols': 'ondemand', 13:18:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:18:40 INFO - 'tooltool.py': '/tools/tooltool.py', 13:18:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:18:40 INFO - '/tools/misc-python/virtualenv.py')}, 13:18:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:18:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:18:40 INFO - 'installer_path': 'installer.exe', 13:18:40 INFO - 'log_level': 'info', 13:18:40 INFO - 'log_name': 'talos', 13:18:40 INFO - 'log_to_console': True, 13:18:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:18:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:18:40 INFO - 'opt_config_files': (), 13:18:40 INFO - 'pip_index': False, 13:18:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:18:40 INFO - 'cmd': ('bash', 13:18:40 INFO - '-c', 13:18:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:18:40 INFO - 'enabled': True, 13:18:40 INFO - 'halt_on_failure': False, 13:18:40 INFO - 'name': 'check_screen_resolution'},), 13:18:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:18:40 INFO - 'cmd': ('bash', 13:18:40 INFO - '-c', 13:18:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:18:40 INFO - 'enabled': True, 13:18:40 INFO - 'halt_on_failure': False, 13:18:40 INFO - 'name': 'check_screen_resolution'},), 13:18:40 INFO - 'run_cmd_checks_enabled': True, 13:18:40 INFO - 'sps_profile': False, 13:18:40 INFO - 'sps_profile_interval': 0, 13:18:40 INFO - 'suite': 'dromaeojs', 13:18:40 INFO - 'system_bits': '32', 13:18:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:18:40 INFO - 'title': 't-yosemite-r7-0085', 13:18:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:18:40 INFO - 'use_talos_json': True, 13:18:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:18:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:18:40 INFO - 'work_dir': 'build'} 13:18:40 INFO - ##### 13:18:40 INFO - ##### Running clobber step. 13:18:40 INFO - ##### 13:18:40 INFO - Running pre-action listener: _resource_record_pre_action 13:18:40 INFO - Running main action method: clobber 13:18:40 INFO - rmtree: /builds/slave/test/build 13:18:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:18:41 INFO - Running post-action listener: _resource_record_post_action 13:18:41 INFO - ##### 13:18:41 INFO - ##### Running read-buildbot-config step. 13:18:41 INFO - ##### 13:18:41 INFO - Running pre-action listener: _resource_record_pre_action 13:18:41 INFO - Running main action method: read_buildbot_config 13:18:41 INFO - Using buildbot properties: 13:18:41 INFO - { 13:18:41 INFO - "project": "", 13:18:41 INFO - "product": "firefox", 13:18:41 INFO - "script_repo_revision": "production", 13:18:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:18:41 INFO - "repository": "", 13:18:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:18:41 INFO - "buildid": "20160302121421", 13:18:41 INFO - "pgo_build": "False", 13:18:41 INFO - "basedir": "/builds/slave/test", 13:18:41 INFO - "buildnumber": 437, 13:18:41 INFO - "slavename": "t-yosemite-r7-0085", 13:18:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:18:41 INFO - "platform": "yosemite_r7", 13:18:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:18:41 INFO - "branch": "fx-team", 13:18:41 INFO - "repo_path": "integration/fx-team", 13:18:41 INFO - "revision": "c36859eaec38c5f0aeb886b97be0950f7a0dd259", 13:18:41 INFO - "stage_platform": "macosx64", 13:18:41 INFO - "builduid": "cf20708f98e04bfe8e2335a5f3552395", 13:18:41 INFO - "slavebuilddir": "test" 13:18:41 INFO - } 13:18:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 13:18:41 INFO - Running post-action listener: _resource_record_post_action 13:18:41 INFO - ##### 13:18:41 INFO - ##### Running download-and-extract step. 13:18:41 INFO - ##### 13:18:41 INFO - Running pre-action listener: _resource_record_pre_action 13:18:41 INFO - Running main action method: download_and_extract 13:18:41 INFO - mkdir: /builds/slave/test/build/tests 13:18:41 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')]} 13:18:41 INFO - https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:18:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 13:18:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 13:18:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 13:18:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 13:18:42 INFO - Downloaded 1277 bytes. 13:18:42 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 13:18:42 INFO - Using the following test package requirements: 13:18:42 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:18:42 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:42 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 13:18:42 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:42 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 13:18:42 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:42 INFO - u'jsshell-mac.zip'], 13:18:42 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:42 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 13:18:42 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:18:42 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:42 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 13:18:42 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:42 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 13:18:42 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:42 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 13:18:42 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:18:42 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:42 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 13:18:42 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:42 INFO - https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:18:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:18:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:18:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/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 13:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/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 13:18:43 INFO - Downloaded 17855031 bytes. 13:18:43 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'] 13:18:43 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 13:18:47 INFO - Return code: 0 13:18:47 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 13:18: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')]} 13:18:47 INFO - https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:18:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:18:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:18:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/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 13:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/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 13:18:48 INFO - Downloaded 17855031 bytes. 13:18:48 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'] 13:18:48 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 13:18:51 INFO - Return code: 0 13:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:51 INFO - https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:18:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 13:18:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 13:18:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/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 13:18:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/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 13:18:52 INFO - Downloaded 10808263 bytes. 13:18:52 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'] 13:18:52 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 13:18:52 INFO - Return code: 0 13:18: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')]} 13:18:52 INFO - https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:18:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:18:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:18:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 13:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjmknHn5SPGOG6CLsQeTOQ/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 13:18:55 INFO - Downloaded 110970390 bytes. 13:18:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:18:55 INFO - mkdir: /builds/slave/test/properties 13:18:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:18:55 INFO - Writing to file /builds/slave/test/properties/build_url 13:18:55 INFO - Contents: 13:18:55 INFO - build_url:https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:18:56 INFO - Running post-action listener: _resource_record_post_action 13:18:56 INFO - Running post-action listener: set_extra_try_arguments 13:18:56 INFO - ##### 13:18:56 INFO - ##### Running populate-webroot step. 13:18:56 INFO - ##### 13:18:56 INFO - Running pre-action listener: _resource_record_pre_action 13:18:56 INFO - Running main action method: populate_webroot 13:18:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:18:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:18:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:18:56 INFO - '--tppagecycles', 13:18:56 INFO - '7'], 13:18:56 INFO - 'tests': ['tsvgm']}}, 13:18:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:18:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:18:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:18:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:18:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:18:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:18:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:56 INFO - 'talos_options': ['--e10s'], 13:18:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:56 INFO - 'tests': ['damp', 'tps']}, 13:18:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:56 INFO - 'talos_options': ['--e10s'], 13:18:56 INFO - 'tests': ['damp', 'tps']}, 13:18:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:18:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:18:56 INFO - 'other': {'tests': ['a11yr', 13:18:56 INFO - 'ts_paint', 13:18:56 INFO - 'tpaint', 13:18:56 INFO - 'sessionrestore', 13:18:56 INFO - 'sessionrestore_no_auto_restore']}, 13:18:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:18:56 INFO - 'tests': ['a11yr', 13:18:56 INFO - 'ts_paint', 13:18:56 INFO - 'tpaint', 13:18:56 INFO - 'sessionrestore', 13:18:56 INFO - 'sessionrestore_no_auto_restore']}, 13:18:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:18:56 INFO - 'tests': ['a11yr', 13:18:56 INFO - 'ts_paint', 13:18:56 INFO - 'tpaint', 13:18:56 INFO - 'sessionrestore', 13:18:56 INFO - 'sessionrestore_no_auto_restore']}, 13:18:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:18:56 INFO - 'tests': ['a11yr', 13:18:56 INFO - 'ts_paint', 13:18:56 INFO - 'tpaint', 13:18:56 INFO - 'sessionrestore', 13:18:56 INFO - 'sessionrestore_no_auto_restore']}, 13:18:56 INFO - 'other_l64': {'tests': ['a11yr', 13:18:56 INFO - 'ts_paint', 13:18:56 INFO - 'tpaint', 13:18:56 INFO - 'sessionrestore', 13:18:56 INFO - 'sessionrestore_no_auto_restore']}, 13:18:56 INFO - 'other_nol64': {'tests': ['a11yr', 13:18:56 INFO - 'ts_paint', 13:18:56 INFO - 'tpaint', 13:18:56 INFO - 'sessionrestore', 13:18:56 INFO - 'sessionrestore_no_auto_restore']}, 13:18:56 INFO - 'svgr': {'tests': ['tsvgx', 13:18:56 INFO - 'tsvgr_opacity', 13:18:56 INFO - 'tart', 13:18:56 INFO - 'tscrollx', 13:18:56 INFO - 'cart']}, 13:18:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:18:56 INFO - 'tests': ['tsvgx', 13:18:56 INFO - 'tsvgr_opacity', 13:18:56 INFO - 'tart', 13:18:56 INFO - 'tscrollx', 13:18:56 INFO - 'cart']}, 13:18:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:56 INFO - 'tests': ['tp5o']}, 13:18:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:56 INFO - 'talos_options': ['--e10s'], 13:18:56 INFO - 'tests': ['tp5o']}, 13:18:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:56 INFO - 'talos_options': ['--xperf_path', 13:18:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:56 INFO - 'tests': ['tp5n']}, 13:18:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:56 INFO - 'talos_options': ['--e10s', 13:18:56 INFO - '--xperf_path', 13:18:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:56 INFO - 'tests': ['tp5n']}}, 13:18:56 INFO - 'talos.zip': {'path': '', 13:18:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:18:56 INFO - Running post-action listener: _resource_record_post_action 13:18:56 INFO - ##### 13:18:56 INFO - ##### Running create-virtualenv step. 13:18:56 INFO - ##### 13:18:56 INFO - Running pre-action listener: _resource_record_pre_action 13:18:56 INFO - Running main action method: create_virtualenv 13:18:56 INFO - Creating virtualenv /builds/slave/test/build/venv 13:18:56 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 13:18:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:18:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:18:56 INFO - Using real prefix '/tools/python27' 13:18:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:18:57 INFO - Installing distribute.............................................................................................................................................................................................done. 13:19:00 INFO - Installing pip.................done. 13:19:00 INFO - Return code: 0 13:19:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962a49a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc3d30>, '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 0x10bbe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdbab20>, '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.wBlQrHxtOp/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.35UAgjIjVu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wBlQrHxtOp/Render', 13:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:00 INFO - 'HOME': '/Users/cltbld', 13:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:00 INFO - 'LOGNAME': 'cltbld', 13:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:00 INFO - 'MOZ_NO_REMOTE': '1', 13:19:00 INFO - 'NO_EM_RESTART': '1', 13:19:00 INFO - 'PAGER': '/bin/cat', 13:19:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:00 INFO - 'PWD': '/builds/slave/test', 13:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:00 INFO - 'SHELL': '/bin/bash', 13:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.35UAgjIjVu/Listeners', 13:19:00 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:00 INFO - 'USER': 'cltbld', 13:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:00 INFO - 'XPC_FLAGS': '0x0', 13:19:00 INFO - 'XPC_SERVICE_NAME': '0', 13:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:00 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 13:19:00 INFO - Cleaning up... 13:19:00 INFO - Return code: 0 13:19:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bf1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962a49a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc3d30>, '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 0x10bbe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdbab20>, '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.wBlQrHxtOp/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.35UAgjIjVu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wBlQrHxtOp/Render', 13:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:00 INFO - 'HOME': '/Users/cltbld', 13:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:00 INFO - 'LOGNAME': 'cltbld', 13:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:00 INFO - 'MOZ_NO_REMOTE': '1', 13:19:00 INFO - 'NO_EM_RESTART': '1', 13:19:00 INFO - 'PAGER': '/bin/cat', 13:19:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:00 INFO - 'PWD': '/builds/slave/test', 13:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:00 INFO - 'SHELL': '/bin/bash', 13:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.35UAgjIjVu/Listeners', 13:19:00 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:00 INFO - 'USER': 'cltbld', 13:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:00 INFO - 'XPC_FLAGS': '0x0', 13:19:00 INFO - 'XPC_SERVICE_NAME': '0', 13:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:00 INFO - Downloading/unpacking psutil>=0.7.1 13:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:19:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:19:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:19:03 INFO - Installing collected packages: psutil 13:19:03 INFO - Running setup.py install for psutil 13:19:03 INFO - building 'psutil._psutil_osx' extension 13:19:03 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 13:19:04 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 13:19:04 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 13:19:04 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 13:19:04 INFO - building 'psutil._psutil_posix' extension 13:19:04 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 13:19:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:19:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:19:04 INFO - ^ 13:19:04 INFO - 1 warning generated. 13:19:04 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 13:19:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:19:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:19:04 INFO - Successfully installed psutil 13:19:04 INFO - Cleaning up... 13:19:04 INFO - Return code: 0 13:19:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bf1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962a49a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc3d30>, '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 0x10bbe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdbab20>, '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.wBlQrHxtOp/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.35UAgjIjVu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wBlQrHxtOp/Render', 13:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:04 INFO - 'HOME': '/Users/cltbld', 13:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:04 INFO - 'LOGNAME': 'cltbld', 13:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:04 INFO - 'MOZ_NO_REMOTE': '1', 13:19:04 INFO - 'NO_EM_RESTART': '1', 13:19:04 INFO - 'PAGER': '/bin/cat', 13:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:04 INFO - 'PWD': '/builds/slave/test', 13:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:04 INFO - 'SHELL': '/bin/bash', 13:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.35UAgjIjVu/Listeners', 13:19:04 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:04 INFO - 'USER': 'cltbld', 13:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:04 INFO - 'XPC_FLAGS': '0x0', 13:19:04 INFO - 'XPC_SERVICE_NAME': '0', 13:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:19:07 INFO - Installing collected packages: mozsystemmonitor 13:19:07 INFO - Running setup.py install for mozsystemmonitor 13:19:07 INFO - Successfully installed mozsystemmonitor 13:19:07 INFO - Cleaning up... 13:19:07 INFO - Return code: 0 13:19:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bf1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962a49a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc3d30>, '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 0x10bbe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdbab20>, '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.wBlQrHxtOp/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.35UAgjIjVu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:19:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wBlQrHxtOp/Render', 13:19:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:07 INFO - 'HOME': '/Users/cltbld', 13:19:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:07 INFO - 'LOGNAME': 'cltbld', 13:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:07 INFO - 'MOZ_NO_REMOTE': '1', 13:19:07 INFO - 'NO_EM_RESTART': '1', 13:19:07 INFO - 'PAGER': '/bin/cat', 13:19:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:07 INFO - 'PWD': '/builds/slave/test', 13:19:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:07 INFO - 'SHELL': '/bin/bash', 13:19:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.35UAgjIjVu/Listeners', 13:19:07 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:19:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:07 INFO - 'USER': 'cltbld', 13:19:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:07 INFO - 'XPC_FLAGS': '0x0', 13:19:07 INFO - 'XPC_SERVICE_NAME': '0', 13:19:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:07 INFO - Downloading/unpacking blobuploader==1.2.4 13:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:10 INFO - Downloading blobuploader-1.2.4.tar.gz 13:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:19:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:19:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:11 INFO - Downloading docopt-0.6.1.tar.gz 13:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:19:11 INFO - Installing collected packages: blobuploader, requests, docopt 13:19:11 INFO - Running setup.py install for blobuploader 13:19:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:19:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:19:11 INFO - Running setup.py install for requests 13:19:12 INFO - Running setup.py install for docopt 13:19:12 INFO - Successfully installed blobuploader requests docopt 13:19:12 INFO - Cleaning up... 13:19:12 INFO - Return code: 0 13:19:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:12 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')]} 13:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:12 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')]} 13:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:12 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 0x10bf1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962a49a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc3d30>, '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 0x10bbe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdbab20>, '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.wBlQrHxtOp/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.35UAgjIjVu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:19:12 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 13:19:12 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 13:19:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wBlQrHxtOp/Render', 13:19:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:12 INFO - 'HOME': '/Users/cltbld', 13:19:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:12 INFO - 'LOGNAME': 'cltbld', 13:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:12 INFO - 'MOZ_NO_REMOTE': '1', 13:19:12 INFO - 'NO_EM_RESTART': '1', 13:19:12 INFO - 'PAGER': '/bin/cat', 13:19:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:12 INFO - 'PWD': '/builds/slave/test', 13:19:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:12 INFO - 'SHELL': '/bin/bash', 13:19:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.35UAgjIjVu/Listeners', 13:19:12 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:19:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:12 INFO - 'USER': 'cltbld', 13:19:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:12 INFO - 'XPC_FLAGS': '0x0', 13:19:12 INFO - 'XPC_SERVICE_NAME': '0', 13:19:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:12 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-UJToJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:12 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-83Kg8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:12 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-r_6dDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:12 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-RcZK3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:13 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Snsvgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:13 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-vJiqX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:13 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-jJXV39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:13 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-R7f2qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:13 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Ll9tRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:13 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-CAEgbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:13 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-VeG366-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:13 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-4FqDw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:13 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-e3jjCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:13 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-xxt2wC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:14 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-OiiWf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:14 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-i4od2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:14 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-PEFe1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:19:14 INFO - Running setup.py install for manifestparser 13:19:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:19:14 INFO - Running setup.py install for mozcrash 13:19:14 INFO - Running setup.py install for mozdebug 13:19:14 INFO - Running setup.py install for mozdevice 13:19:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:19:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:19:15 INFO - Running setup.py install for mozfile 13:19:15 INFO - Running setup.py install for mozhttpd 13:19:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:19:15 INFO - Running setup.py install for mozinfo 13:19:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:19:15 INFO - Running setup.py install for mozInstall 13:19:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:19:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:19:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:19:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:19:15 INFO - Running setup.py install for mozleak 13:19:15 INFO - Running setup.py install for mozlog 13:19:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:19:15 INFO - Running setup.py install for moznetwork 13:19:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:19:16 INFO - Running setup.py install for mozprocess 13:19:16 INFO - Running setup.py install for mozprofile 13:19:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:19:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:19:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:19:16 INFO - Running setup.py install for mozrunner 13:19:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:19:16 INFO - Running setup.py install for mozscreenshot 13:19:16 INFO - Running setup.py install for moztest 13:19:16 INFO - Running setup.py install for mozversion 13:19:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:19:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:19:16 INFO - Cleaning up... 13:19:16 INFO - Return code: 0 13:19:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:16 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')]} 13:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:16 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')]} 13:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:16 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 0x10bf1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962a49a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc3d30>, '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 0x10bbe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdbab20>, '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.wBlQrHxtOp/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.35UAgjIjVu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:19:16 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 13:19:16 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 13:19:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wBlQrHxtOp/Render', 13:19:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:16 INFO - 'HOME': '/Users/cltbld', 13:19:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:16 INFO - 'LOGNAME': 'cltbld', 13:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:16 INFO - 'MOZ_NO_REMOTE': '1', 13:19:16 INFO - 'NO_EM_RESTART': '1', 13:19:16 INFO - 'PAGER': '/bin/cat', 13:19:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:16 INFO - 'PWD': '/builds/slave/test', 13:19:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:16 INFO - 'SHELL': '/bin/bash', 13:19:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.35UAgjIjVu/Listeners', 13:19:16 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:19:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:16 INFO - 'USER': 'cltbld', 13:19:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:16 INFO - 'XPC_FLAGS': '0x0', 13:19:16 INFO - 'XPC_SERVICE_NAME': '0', 13:19:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:17 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-TUgnH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:17 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)) 13:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:17 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-mn7Gfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:17 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)) 13:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:17 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-KA80Nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:17 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)) 13:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:17 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-EFdJqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:17 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)) 13:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:17 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-SwJVY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:17 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)) 13:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:17 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-bMpfVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:17 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)) 13:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:17 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-PJBx0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:17 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)) 13:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:17 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Y0El6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:18 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)) 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:18 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-bH1FL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:18 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)) 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:18 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-VrtdQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:18 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)) 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:18 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-EjnNI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:18 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)) 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:18 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-IB7usd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:18 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)) 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:18 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-WRWTwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:18 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)) 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:18 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-iZ5F_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:18 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)) 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:18 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-firrpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:18 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)) 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:18 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-jBS1KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:18 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)) 13:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:18 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-7wwdNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:19 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)) 13:19:19 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)) 13:19:19 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)) 13:19:19 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)) 13:19:19 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)) 13:19:19 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)) 13:19:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:19:19 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 13:19:19 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 13:19:19 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 13:19:19 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 13:19:19 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 13:19:19 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 13:19:21 INFO - Downloading blessings-1.6.tar.gz 13:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:19:21 INFO - Installing collected packages: blessings 13:19:21 INFO - Running setup.py install for blessings 13:19:21 INFO - Successfully installed blessings 13:19:21 INFO - Cleaning up... 13:19:21 INFO - Return code: 0 13:19:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:21 INFO - Reading from file tmpfile_stdout 13:19:21 INFO - Current package versions: 13:19:21 INFO - blessings == 1.6 13:19:21 INFO - blobuploader == 1.2.4 13:19:21 INFO - docopt == 0.6.1 13:19:21 INFO - manifestparser == 1.1 13:19:21 INFO - mozInstall == 1.12 13:19:21 INFO - mozcrash == 0.16 13:19:21 INFO - mozdebug == 0.1 13:19:21 INFO - mozdevice == 0.48 13:19:21 INFO - mozfile == 1.2 13:19:21 INFO - mozhttpd == 0.7 13:19:21 INFO - mozinfo == 0.9 13:19:21 INFO - mozleak == 0.1 13:19:21 INFO - mozlog == 3.1 13:19:21 INFO - moznetwork == 0.27 13:19:21 INFO - mozprocess == 0.22 13:19:21 INFO - mozprofile == 0.28 13:19:21 INFO - mozrunner == 6.11 13:19:21 INFO - mozscreenshot == 0.1 13:19:21 INFO - mozsystemmonitor == 0.0 13:19:21 INFO - moztest == 0.7 13:19:21 INFO - mozversion == 1.4 13:19:21 INFO - psutil == 3.1.1 13:19:21 INFO - requests == 1.2.3 13:19:21 INFO - wsgiref == 0.1.2 13:19:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:21 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 0x10bf1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962a49a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc3d30>, '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 0x10bbe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdbab20>, '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.wBlQrHxtOp/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.35UAgjIjVu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:19:21 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 13:19:21 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 13:19:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wBlQrHxtOp/Render', 13:19:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:21 INFO - 'HOME': '/Users/cltbld', 13:19:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:21 INFO - 'LOGNAME': 'cltbld', 13:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:21 INFO - 'MOZ_NO_REMOTE': '1', 13:19:21 INFO - 'NO_EM_RESTART': '1', 13:19:21 INFO - 'PAGER': '/bin/cat', 13:19:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:21 INFO - 'PWD': '/builds/slave/test', 13:19:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:21 INFO - 'SHELL': '/bin/bash', 13:19:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.35UAgjIjVu/Listeners', 13:19:21 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:19:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:21 INFO - 'USER': 'cltbld', 13:19:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:21 INFO - 'XPC_FLAGS': '0x0', 13:19:21 INFO - 'XPC_SERVICE_NAME': '0', 13:19:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:22 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)) 13:19:22 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)) 13:19:22 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)) 13:19:22 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)) 13:19:22 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)) 13:19:22 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)) 13:19:22 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)) 13:19:22 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)) 13:19:22 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)) 13:19:22 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)) 13:19:22 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)) 13:19:22 INFO - Cleaning up... 13:19:22 INFO - Return code: 0 13:19:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:22 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 0x10bf1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962a49a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc3d30>, '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 0x10bbe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdbab20>, '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.wBlQrHxtOp/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.35UAgjIjVu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:19:22 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 13:19:22 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 13:19:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wBlQrHxtOp/Render', 13:19:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:22 INFO - 'HOME': '/Users/cltbld', 13:19:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:22 INFO - 'LOGNAME': 'cltbld', 13:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:22 INFO - 'MOZ_NO_REMOTE': '1', 13:19:22 INFO - 'NO_EM_RESTART': '1', 13:19:22 INFO - 'PAGER': '/bin/cat', 13:19:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:22 INFO - 'PWD': '/builds/slave/test', 13:19:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:22 INFO - 'SHELL': '/bin/bash', 13:19:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.35UAgjIjVu/Listeners', 13:19:22 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:19:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:22 INFO - 'USER': 'cltbld', 13:19:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:22 INFO - 'XPC_FLAGS': '0x0', 13:19:22 INFO - 'XPC_SERVICE_NAME': '0', 13:19:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:22 INFO - Downloading/unpacking jsonschema 13:19:22 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 13:19:22 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 13:19:22 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 13:19:22 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 13:19:22 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 13:19:22 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 13:19:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:19:24 INFO - Downloading/unpacking functools32 (from jsonschema) 13:19:24 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 13:19:24 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 13:19:24 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 13:19:24 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 13:19:24 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 13:19:24 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 13:19:25 INFO - Downloading functools32-3.2.3-2.tar.gz 13:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:19:25 INFO - warning: no files found matching '*.txt' 13:19:25 INFO - no previously-included directories found matching 'build' 13:19:25 INFO - no previously-included directories found matching 'dist' 13:19:25 INFO - no previously-included directories found matching '.git*' 13:19:25 INFO - Installing collected packages: jsonschema, functools32 13:19:25 INFO - Running setup.py install for functools32 13:19:25 INFO - warning: no files found matching '*.txt' 13:19:25 INFO - no previously-included directories found matching 'build' 13:19:25 INFO - no previously-included directories found matching 'dist' 13:19:25 INFO - no previously-included directories found matching '.git*' 13:19:25 INFO - Successfully installed jsonschema functools32 13:19:25 INFO - Cleaning up... 13:19:25 INFO - Return code: 0 13:19:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:25 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 0x10bf1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962a49a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc3d30>, '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 0x10bbe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdbab20>, '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.wBlQrHxtOp/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.35UAgjIjVu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 13:19:25 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 13:19:25 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 13:19:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wBlQrHxtOp/Render', 13:19:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:25 INFO - 'HOME': '/Users/cltbld', 13:19:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:25 INFO - 'LOGNAME': 'cltbld', 13:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:25 INFO - 'MOZ_NO_REMOTE': '1', 13:19:25 INFO - 'NO_EM_RESTART': '1', 13:19:25 INFO - 'PAGER': '/bin/cat', 13:19:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:25 INFO - 'PWD': '/builds/slave/test', 13:19:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:25 INFO - 'SHELL': '/bin/bash', 13:19:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.35UAgjIjVu/Listeners', 13:19:25 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:19:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:25 INFO - 'USER': 'cltbld', 13:19:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:25 INFO - 'XPC_FLAGS': '0x0', 13:19:25 INFO - 'XPC_SERVICE_NAME': '0', 13:19:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:26 INFO - Downloading/unpacking flake8 13:19:26 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 13:19:26 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 13:19:26 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 13:19:26 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 13:19:26 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 13:19:26 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 13:19:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:19:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:19:28 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 13:19:28 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 13:19:28 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 13:19:28 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 13:19:28 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 13:19:28 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 13:19:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:19:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:19:28 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 13:19:28 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 13:19:28 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 13:19:28 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 13:19:28 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 13:19:28 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 13:19:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:19:29 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 13:19:29 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 13:19:29 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 13:19:29 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 13:19:29 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 13:19:29 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 13:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:19:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:19:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:19:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:19:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:19:29 INFO - no previously-included directories found matching 'docs/_build' 13:19:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:19:29 INFO - Running setup.py install for pep8 13:19:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:19:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:19:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:19:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:19:29 INFO - no previously-included directories found matching 'docs/_build' 13:19:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:19:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:19:29 INFO - Cleaning up... 13:19:30 INFO - Return code: 0 13:19:30 INFO - Running post-action listener: _resource_record_post_action 13:19:30 INFO - Running post-action listener: _start_resource_monitoring 13:19:30 INFO - Starting resource monitoring. 13:19:30 INFO - ##### 13:19:30 INFO - ##### Running install step. 13:19:30 INFO - ##### 13:19:30 INFO - Running pre-action listener: _resource_record_pre_action 13:19:30 INFO - Running main action method: install 13:19:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:30 INFO - Reading from file tmpfile_stdout 13:19:30 INFO - Detecting whether we're running mozinstall >=1.0... 13:19:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:19:30 INFO - Reading from file tmpfile_stdout 13:19:30 INFO - Output received: 13:19:30 INFO - Usage: mozinstall [options] installer 13:19:30 INFO - Options: 13:19:30 INFO - -h, --help show this help message and exit 13:19:30 INFO - -d DEST, --destination=DEST 13:19:30 INFO - Directory to install application into. [default: 13:19:30 INFO - "/builds/slave/test"] 13:19:30 INFO - --app=APP Application being installed. [default: firefox] 13:19:30 INFO - mkdir: /builds/slave/test/build/application 13:19:30 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'] 13:19:30 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 13:20:04 INFO - Reading from file tmpfile_stdout 13:20:04 INFO - Output received: 13:20:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:20:04 INFO - Running post-action listener: _resource_record_post_action 13:20:04 INFO - ##### 13:20:04 INFO - ##### Running run-tests step. 13:20:04 INFO - ##### 13:20:04 INFO - Running pre-action listener: _resource_record_pre_action 13:20:04 INFO - Running main action method: run_tests 13:20:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:20:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:20:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:20:04 INFO - 2016-03-02 13:20:04.836 screenresolution[1640:7624] starting screenresolution argv=screenresolution get 13:20:04 INFO - 2016-03-02 13:20:04.838 screenresolution[1640:7624] Display 0: 1600x1200x32@60 13:20:04 INFO - 2016-03-02 13:20:04.844 screenresolution[1641:7626] starting screenresolution argv=screenresolution list 13:20:04 INFO - Available Modes on Display 0 13:20:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:20:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:20:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:20:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:20:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:20:05 INFO - Intel Iris: 13:20:05 INFO - Chipset Model: Intel Iris 13:20:05 INFO - Type: GPU 13:20:05 INFO - Bus: Built-In 13:20:05 INFO - VRAM (Dynamic, Max): 1536 MB 13:20:05 INFO - Vendor: Intel (0x8086) 13:20:05 INFO - Device ID: 0x0a2e 13:20:05 INFO - Revision ID: 0x0009 13:20:05 INFO - Displays: 13:20:05 INFO - Display: 13:20:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:20:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:20:05 INFO - Display Serial Number: 1600x1200 60 13:20:05 INFO - Main Display: Yes 13:20:05 INFO - Mirror: Off 13:20:05 INFO - Online: Yes 13:20:05 INFO - Rotation: Supported 13:20:05 INFO - Return code: 0 13:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:20:05 INFO - Python 2.7.3 13:20:05 INFO - Return code: 0 13:20:05 INFO - grabbing minidump binary from tooltool 13:20: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')]} 13:20:05 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 0x10bdc3d30>, '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 0x10bbe7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdbab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:20:05 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 13:20:05 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 13:20:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:20:05 INFO - Return code: 0 13:20:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:20:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:20:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:20:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:20:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:20:06 INFO - Return code: 0 13:20:06 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:20:06 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0085 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:20:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wBlQrHxtOp/Render', 13:20:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:06 INFO - 'HOME': '/Users/cltbld', 13:20:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:06 INFO - 'LOGNAME': 'cltbld', 13:20:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:20:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:06 INFO - 'MOZ_NO_REMOTE': '1', 13:20:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:20:06 INFO - 'NO_EM_RESTART': '1', 13:20:06 INFO - 'PAGER': '/bin/cat', 13:20:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:06 INFO - 'PWD': '/builds/slave/test', 13:20:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:20:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:06 INFO - 'SHELL': '/bin/bash', 13:20:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.35UAgjIjVu/Listeners', 13:20:06 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 13:20:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:06 INFO - 'USER': 'cltbld', 13:20:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:06 INFO - 'XPC_FLAGS': '0x0', 13:20:06 INFO - 'XPC_SERVICE_NAME': '0', 13:20:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:20:06 INFO - mozversion application_buildid: 20160302121421 13:20:06 INFO - mozversion application_changeset: c36859eaec38c5f0aeb886b97be0950f7a0dd259 13:20:06 INFO - mozversion application_display_name: Nightly 13:20:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:20:06 INFO - mozversion application_name: Firefox 13:20:06 INFO - mozversion application_remotingname: firefox 13:20:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:20:06 INFO - mozversion application_vendor: Mozilla 13:20:06 INFO - mozversion application_version: 47.0a1 13:20:06 INFO - mozversion platform_buildid: 20160302121421 13:20:06 INFO - mozversion platform_changeset: c36859eaec38c5f0aeb886b97be0950f7a0dd259 13:20:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:20:06 INFO - mozversion platform_version: 47.0a1 13:20:06 INFO - using testdate: 1456953606 13:20:06 INFO - actual date: 1456953606 13:20:06 INFO - starting webserver on 'localhost:49270' 13:20:06 INFO - SUITE-START | Running 2 tests 13:20:06 INFO - TEST-START | dromaeo_css 13:20:06 INFO - operating with platform_type : mac_ 13:20:06 INFO - Initialising browser for dromaeo_css test... 13:20:06 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmplZS5s2/profile http://localhost:49270/getInfo.html) 13:20:08 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 13:20:08 INFO - PROCESS | 1659 | colorDepth:24 13:20:08 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 13:20:08 INFO - PROCESS | 1659 | __metrics 13:20:09 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:20:09 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:20:09 INFO - TEST-INFO | 1659: exit 0 13:20:09 INFO - Browser initialized. 13:20:09 INFO - Running cycle 1/1 for dromaeo_css test... 13:20:09 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmplZS5s2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:20:21 INFO - PROCESS | 1662 | RSS: Main: 243634176 13:20:21 INFO - PROCESS | 1662 | 13:21:12 INFO - PROCESS | 1662 | 1456953672649 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] 13:23:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 13:23:24 INFO - PROCESS | 1662 | RSS: Main: 375377920 13:23:24 INFO - PROCESS | 1662 | 13:26:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 13:26:27 INFO - PROCESS | 1662 | RSS: Main: 375033856 13:26:27 INFO - PROCESS | 1662 | 13:29:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 13:29:30 INFO - PROCESS | 1662 | RSS: Main: 375562240 13:29:30 INFO - PROCESS | 1662 | 13:32:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 13:32:33 INFO - PROCESS | 1662 | RSS: Main: 330215424 13:32:33 INFO - PROCESS | 1662 | 13:35:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 13:35:36 INFO - PROCESS | 1662 | RSS: Main: 332894208 13:35:36 INFO - PROCESS | 1662 | 13:38:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 13:38:39 INFO - PROCESS | 1662 | RSS: Main: 379228160 13:38:39 INFO - PROCESS | 1662 | 13:38:39 INFO - PROCESS | 1662 | __start_tp_report 13:38:39 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 13:38:39 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 13:38:39 INFO - PROCESS | 1662 | |i|pagename|runs| 13:38:39 INFO - PROCESS | 1662 | |0;dojo.html;3287.6547962463933;3357.261402491452;3384.6107697614766;3472.6700963408484;3494.405950988332;5416.133418653007;5462.180672899062;5633.915491267634;5637.943620563793;5643.379228284885;5620.690862002588;5624.634398764088;5661.886762264752;5751.884962300762;5757.654540727559;5071.594272458213;5102.234664800291;5124.718140502271;5144.6655967362;5239.947600523984;5191;5201.2458193561915;5240.842774716764;5266.131088370415;5299.364076310848;4219.839544125375;5102.515261050195;5162.457941916082;5164.6384753067305;5174;5129.153689641204;5160.432352441228;5169.793208271664;5209.062368773619;5223.686578805284;5105.642605017651;5120.078385890538;5137.614678899097;5151.150060240094;5156.613254005964;5448.945510544923;5542.63972841764;5551.750171242304;5568.52667523261;5586.525145362649;6087.3303936566945;6098.664573448458;6160.938390616081;6164.938350616526;6170.7531698732;6210.627362358273;6243.219597550306;6250.718717657671;6252.499800015988;6262.937370626281;5503.394626591072;5714.771409143629;5718;5730.914036289418;5732.570057245724;5342.412334643186;6263.96868015657;6271.686415679198;6330.873382532323;6392.4566411854585;5958.195643588147;6040;6043.8791224175275;6057.212562366953;6063.7574497020505;6048.425399587032;6162.044883043135;6184.319724830265;6192.040233763774;6196.783112591128;5980.790672326448;6028.065649824284;6053.576249662569;6057.18228039209;6059.666718330446;6064.363241859542;6066.150738896558;6077.483413909778;6080.939190608037;6084.452399283997;4779.283107533898;4812.25410061441;4842.685225460405;4845.152098382769;4871.244957031666;4304.677149213821;4342;4353.107612939403;4380.9780951095045;4397.648188144941;5582.218489411485;5603.467670571289;5604.6917419541505;5606.074997625346;5619.690916999522;6102.542309326818;6115.118650813375;6155.72299246535;6208.875822483525;6220.937790622036;5550.361708403505;5565.888682226414;5578.358488773762;5587.27365442498;5603.131514615241;4521.864344069683;5270.393904700932;5296.179092240709;5298.735063246822;5363.597730170253;6219.906701399483;6305.432511074117;6378.425941665272;6402.807915762534;6412.935870641234;6196.876062478816;6200.689965501617;6201;6205.5345849062405;6206.627602343874;6349.6507692077375;6355.396237357444;6359.268684101203;6385.45723613498;6391.424771770563;5926.822195334147;6031.336552979256;6044.697765111815;6099.975683468331;6124.14262003311;5410.621256512007;5944.959632064285;6168.537359697951;6182.041783523561;6188.659623720739;5911.231539899785;5942.183620354301;5977.641341519523;5998.610090344114;6004.249468816398;5849.473547380756;5950.137230101697;6053.334133245251;6055.576109672457;6097.817065488042;5792.986227410102;5802.564807639359;5810.448007439287;5813.215215945962;5814.912776308443;5888.057910734262;5963.135345374983;5964.194833697569;5967.76128954837;6014.789482368096;5826.242588463472;5832.766689332549;5868.765249390148;5908.350081490947;5920 13:38:39 INFO - PROCESS | 1662 | |1;ext.html;549.8645297460746;573.0001147996744;575.3113084031767;591.9200907877437;632.5161251642493;37775.244495110084;38083.619163808355;38106.80946595267;38112.47550097996;38188.236235275275;39718.205635887265;40185.79442616719;40263.59736402635;40306.79079627609;40405.59594404055;9460.526973651307;9685.806283874354;9698.418094914292;9706.980767019468;9715.70852874415;8244.628991695357;9192.908070919306;9446.102620251066;9616.27877909156;9621.759456013586;9579.137877591016;9599.04009599038;9650.71047868565;9662.806743865154;9669.903300967006;9510.857337139949;9606.711798646053;9628.47043412612;9630.229581633523;9631.470269135194;9544.761380965532;9695.951520242354;9705.466199359033;9711.494718318672;9719.805603887882;38980.41529377062;39151.60848391536;39176.020599485244;39245.41131883024;39314.60685393138;3182.315802102536;3295.5880514935634;3332.766706330558;3696.704263658901;3704.85180592776;27990.440191196267;28297.434051319065;28581.28546786326;28829.42341153165;28881.711182888113;2701.91894243173;2706.512827691015;2709.76705598952;2842.0337085391066;2933.281346070205;471973;473682.6315868433;473722;474420;475239;43519.34720979188;43524.56475435205;43681;59002;59515.10727339093;35110.82444587761;35163.82418087893;42813.14373712508;42949.57050429518;42966.78516607397;11824.76350473003;14425.278736063156;14629.78055329171;14656.267186640625;14710.852891470948;12130.575429859913;12229.694257643452;12241.265524068407;12242.44908979098;12251.387430628432;14156.575302740934;14176.858231417555;14202.502912398017;14233.217173055375;14358.784618230735;5166.61250406221;5401.783928642889;6263.561550691499;6310.368963103653;6372.845441506392;920.4661296448044;924.2882980105416;1007.9647212347533;1076.7603384959266;1085.9511321990371;28175;28573;28721.56917646237;28981.275468113465;29014.12957611275;1064.2816099133054;1068.6793961811582;1106.2090605217309;1139.2196345503357;1225.08730995409;14371.496997605034;14443.92778036124;14636.634084147981;14698.412063517553;14787;503408;504753;509645;510004;510813;43434.34848477212;52798.73600632049;53930.460695393325;54579.454205458234;54827;1308.5943357559188;1336.2717319061135;1411.527138408624;1441.1857300625113;1529.62524181574;27725;27873.08061420326;28060.579091313237;28360.85819570889;28433.573496397155;39803.40294895637;43256.13487730291;43306.35040474332;43329.783351083046;43390.783046084565;295260;307094;307374;307502;307910;27827.721722782513;31637;31859.68140318567;31879.840600796848;33151.171220719676;39869.80390588287;40595.78212653625;41170.794146029075;41450.79274603607;44255.336169956834;33704.494432583044;34744.6102155921;35102;35359;35463.936081917585;34250.65749342475;34250.97247082592;34820.30359392747;35085.82457087698;35167.648323516434;30530.057988751654;31292.68707312898;31892.362152756352;34931.650683493855;35389.292214156085;29485;30365;30439.695603043685;30600;30742.38515229638;23122.06865893792;23226.070957161523;23565;23675.289741307788;23766.049358025484 13:38:39 INFO - PROCESS | 1662 | |2;jquery.html;293.8971360023991;353.29693909120857;354.43487876155126;359.8560575769692;363.65271166036405;19404.78805183396;19873.20507179713;20472.07875645594;20522.692159617618;20524.179032838667;15502.224888755574;16982.745258821098;19372.031398430056;19412.611747765073;20272.493187670316;5650.208970744099;5837.036888913324;5870.9119363209375;5873.941260587403;5874.441928016831;4146.046409325857;5674.233978412903;5712.857178570527;5782;5854.882902341972;4315.223259813232;6118.63288202707;6364;6368.5860419072615;6370.840728981766;6089.177960975256;6319.083732858733;6327.303996560375;6340.397662222082;6371.458426033792;5465.426130256305;5477.5070243677865;5510.283663123809;5516.062269414209;5518.641288316287;24561.631575526382;24876.626850597255;25598.23205303844;26060.8696956514;26061.08786192493;1863.6738570750065;2091.8612901465117;2344.2498400511845;2706.458708258356;2840.701726318748;9505.572249248731;9536.952315238448;9603.32776705631;9768.560414781352;9813.607455701764;1631.9428819991363;1668.5578321744747;1722.7243641017376;1726.5079452356144;1749.5101371615967;95891;104039;106684.93315066828;109413;111235.88764112337;11154.219204655596;11162.386068766296;11177;11185.944070279596;11372.374519401512;13592.728145437035;13601.727965440834;13635.454581816815;13646.181229126285;13661;8209.425340226127;8255.504669719836;8320.70877519284;8442.704505342406;8456.450330728483;6947.617881016593;8367.748967530863;8384.622691978875;8393.664253429795;8480.448770829877;4309.59058889405;4386.627136693353;4386.627136693417;4441.311596702516;4469.9776501117285;1711.3582406597525;1780.8041115477288;1847.4272975377676;1859.2934684819681;1868.392772348992;803.3573141486787;843.8649816029529;903.823754367892;905.4748246017294;1020.3979652005353;17189.7421538677;19303.51741206453;20015.09932053061;20528.973551322673;20634.690479642817;911.9498427586414;923.9676611318572;942.673892507339;949.4208532794989;973.6446197138135;10669.41318227505;10952.890471095347;10965.725856853483;10988.28576142564;11324.508608106204;608340;625324;630515.84742076;640508;640894;107876;109842;110046.44976775224;110113;112107.43946280217;1001.249063202598;1014.2342531388902;1015.2487159501916;1032.850236715672;1032.8812186598486;17652.558686032953;17765.11174441247;17828.55428614295;18284.908575457037;18441.24808143224;49855;49979.50020499749;50041.24938126004;50254.49745502498;50976.98046039133;72723;73729.26270737438;73823.63088184525;73975.6301218512;74554;7772.805679858049;8002.07976082758;8036.357091432555;8103.635336409993;8351.749447516584;9368.250539956924;12167.965722913297;12768.61694149177;13129.671758206121;13172;10898.727531811768;11158.832617510907;11511.884881151416;11549.018333441416;11553.364564949008;10963.122950164126;11114.22200445961;11183.608573700207;11345.6767320778;11522;9626.807463850824;11331.773364532828;11607.6517704469;11654.941725291319;11759.235649683085;7894.1316455188735;7909.683612655429;8176.305014073632;8177.4684645497855;8178.7955301117945;10430.322029068086;11327.376994265394;11611.593594224161;11698;11722.296662200295 13:38:39 INFO - PROCESS | 1662 | |3;mootools.html;1381.4543255414105;1504.3982407037183;1513.8107736532936;1746.1792957310067;1931.362650325392;7666.578338191404;8175.182481751822;8329.791755206123;8340.165983401657;8342.249197572217;8114.431989760719;8194.057683366414;8276.213759692835;8281.503109813415;8294.921660184184;2115.6614941609346;2345.9178928737497;2381.1070848431796;2407.3018824540864;2410.18053861687;2377.6552399902002;2379.8929048192786;2383.2492764779126;2386.260259319608;2389.629607410854;2334.7898689117974;2352.5882970480184;2375.6674065630827;2390.3785015895905;2392.9760702393014;2343.7890589846997;2377.857328560292;2379.9048038078454;2393.8803059847023;2411.397150712322;2321.837471376987;2396.221228100874;2406.097713357491;2411.6985376827897;2417.613181890889;8387.664493420256;8459.83080338396;8462.915370846275;8477.533735644538;8480.575971201477;5117.309163262949;5213.983273261715;5224.216367544898;5251.921221181686;5253.3958594761325;3468.219650578625;3547.94678079829;3594.802285874276;3624.039629498185;3661.286049220403;1026.6560702164784;1036.461040259061;1040.4121671255716;1063.3566692151214;1067.2315932528568;9552.57013434397;11301.943490282578;11308.604198853083;11320.433978301053;11321.603743869007;4667.463241727177;4715.952840471551;4738.265568836836;4779.378680771478;4811.879703007383;9747.707568772948;9751.561179746928;9767.365121267096;9771.706848794547;9777;5256.737163141827;5265.052290587654;5290.365156181283;5292.179712144623;5300.44345343741;4301.935470967938;4405.625521830616;4679.812807487662;4745.240761478216;4758.690685105457;3758.8872333830027;3808.638179372955;3813.7139714521522;3836.712246581518;3870.787106709102;1260.8171815086762;1267.1193520503161;1269.5112381732915;1278.9232646041266;1279.366713476835;1316.0787448785889;1328.0504439325928;1352.1684164238923;1360.1363134409721;1361.2104979112091;7842.5686587237105;7922.049354077432;8084.959575202086;8107.310878575269;8119.228673276029;1183.6153250193722;1184.5735535207318;1197.6347214099783;1206.3666575048169;1209.7459533498063;6106.480949119375;6149.385061493905;6219.813405597839;6223.96888015566;6225.595336303217;9841.55712992917;10166.339187952759;10284.485775711184;10291.279610427348;10362.274640775224;9943.900560994442;10229.795404092025;10238.33450825694;10258.897411025944;10363.740906477398;7791.688332466638;7922.643481043367;7969.083555391204;8033;8034.357251419872;7580.204078571891;7591.240875912365;7623.313901748869;7634.007579014693;7677;9013.504257265913;9241.445513269226;9264.39781414206;9441.716748497556;9453.621855125994;9292.442453452815;9552.755102551035;9559;9612.711618651172;9655.227581793299;6519.641419721771;6702.463802895659;6711.12755341822;7177.605231712306;7285.417166626551;7201.171865235565;7914.287714105758;7935.761927141964;7944.880826787487;7951.761447156595;6940.652967351713;7005.509614326948;7033.648317584202;7149.356557909813;7171.856562868609;6930.306969303029;6959.478039146983;7019.789406317818;7066.929330706833;7097.893531596927;6411.198600174978;7208.27917208275;7413.592252426169;7523.3229009389415;7536.660850261642;6839.726410943506;6841.692123854339;6889.207741109836;6904.758333458305;6910.378065974087;6910.516263861682;6971.128608923885;6979.511434199558;7001.159860816734;7029.472789540907 13:38:39 INFO - PROCESS | 1662 | |4;prototype.html;303.1662926950885;305.2582225192781;309.84972288440105;312.42981558655447;314.8567401832167;6503.057056726778;6613.437857782088;6665.100211471456;6699.464042876571;6709.060731497594;6604;6657.167854018247;6697.2633010368945;6702.262751097375;6719.966400168005;3815.3212586462005;4591.816327346902;4703.952960470386;4847.151748444017;4876.317315575804;4827.975860120694;4834.154023045953;4844.442889067749;4858.1012512685265;4865.732384718839;4787.210110331791;4795.928061079087;4820.6143508519235;4824.6381521385865;4830.454254638517;3972.3842804365368;4578.702384345007;4711.882202944919;4813.566778989908;4833.613310935117;3579.284143171376;4115.52671442785;4127.814248358831;4140.136938377742;4156.168766246733;5667.4049224831215;5789.247397838254;6336.58812177207;6343.429091381751;6345.873082538324;5631.352394474647;5649.067903795869;5656.773729050833;5661.179129026268;5663.745131469093;6992.6154061526595;6993.440524758007;7001.194862590816;7010.193827709828;7011.123609548807;4379.934300985487;4542.772861356919;4579.152856721517;4581.358609794632;4624.398828152319;7307.159676637201;7338.4496162788;7350.889736653954;7389.039424874785;7401.9629901850685;4674.929876051862;4682.9531704683195;4682.9765851171205;4687.81248750053;4687.9765601171775;4751.52484751529;4769.928451073168;4770.61835053195;4775.2359622460235;4775.976120119447;5613.410591887875;5622.240997465372;5632.352279487829;5640.238567793295;5658.688772117573;6748.414122681166;7007.4394048476;7036.92963070373;7053.188883278386;7096.432285417154;1639.6966561186218;1652.3473228075084;1664.4756901576206;1665.3338664534042;1667.1830802906488;994.125169850527;1035.1460045462522;1058.396713873085;1061.0185578340004;1072.4798472740715;6316.431521163117;6455.096286519891;6570.671466426659;6583.374579414948;6600.405963463311;6300.401461861115;7119.394851437686;7320;7328.59692716895;7329.743458979016;6511.772087976898;6518.217813862272;6530.804075877636;6552.115464412243;6559.6064236145985;3836.462895194675;3851.1527463957887;3884.76691398517;3893.6106389361403;3895.8831235062426;6199.411055949678;7689.19263477338;7695.692172313156;7701.460897737216;7722.227777222345;6203.976343903206;7485.962570187223;7591.051118610174;7600.8479830403085;7606.429517786189;5427.864303392446;7651.923480765233;7669.156392796899;7673.462857600138;7698.961505192438;6989.615571143636;7332.193458719643;7332.340089391981;7346.045014148127;7361.227071157666;7218.747343843151;7228.602426866572;7239.384652304613;7242.855142897007;7253.1296244451005;7625.466217364731;7629.2752188542;7658.234176582298;7665.3101220890385;7668.769936901902;4712.59942904857;4715.93891374438;4717.410323709536;4724.598409135262;4733.100710864925;6986.476014298846;7296;7302.9410735442;7307.8538429232185;7315.524490908074;7034.191068027242;7063.71745130189;7067.6819543119655;7071.540349877241;7113.893291600733;6079.513638908965;6681.763873683384;7025.789226323219;7028;7040.190378106583;6857.27998560144;6862.3137686230975;6866.141732283465;6873.621950792754;6883.8967415487805;6713.731450741916;7066.364027237573;7070.893936591058;7082.256363081802;7084.752033678797;5504.256925315031;6634.2087636336955;6824.863502729819;6873.243943166148;6961.547499412522 13:38:39 INFO - PROCESS | 1662 | |5;yui.html;630.4515071887458;676.5129107042928;728.7813655903229;749.7863109013932;781.718581310728;14661.340239689212;14809;14833.703325933475;14866.55400337989;14866.77699834502;15311.081335119901;15709.764353534678;15725.135117568529;15786.84213157868;15840.524784256491;695.1241435790914;699.0876905638165;833.679033572076;841.2176675691604;845.137959281534;849.2611428057598;860.7245681381929;861.4271509446243;861.7543999960012;861.8491763941286;901.0358915959926;901.0673952459206;901.4771432569127;901.5807649443008;903.9819203615924;724.9746258880966;732.3116270705519;879.3317079019927;897.1701176411825;902.3593248793364;661.0150875195924;661.137215933207;662.9823221355244;663.4029373563783;663.5189487621436;14833.480828170963;14915.477958271409;14928.32822522989;14942.953993220479;14946.953713240078;12234.449449774782;12350;12378.133530652858;12478.18891772041;12538.373081345897;9891.851622225673;10008.099271065566;10025.89974100257;10061.14480269178;10364.637237696645;3429.879954201616;3457.550518432613;3491.8254087295786;3515.209077957439;3573.928521429557;67802.32197678059;87853.68219476713;87978;89081;89159;9120.133587309196;9166.86249706255;9379;9415.529223538795;9585.520723963775;20643.793562064187;20644.89677551633;20670.069846856928;20685.17259309641;20959.476013099793;7511.8497630047095;7558.811029724301;7574.621268936641;7733.4973226740085;7873.566953817595;4060.5127384714024;4092.7544347339253;4115.9176816464105;4129.587041295847;4169.145325208325;3479.5476588043393;3517.806520641338;3547.2018795770746;3550.04148879801;3550.627184145679;628.3496581038694;644.8420137066355;649.665422307512;659.6569783712442;672.2034389248756;570.3070769015666;572.8252882870764;588.3469349022581;596.5972968246504;605.9333473317931;7900.604969751489;8057.113717491071;8100.392470564731;8120.3503719702285;8323.522956282328;488.2115383655442;561.4553882733742;586.4370204603629;591.914172444993;598.0909018292172;3774.301754175486;3782.6406491383273;3787.9431808522895;3843.9237013636225;4038.495188101487;94721;95960;96826.51586742162;98093;98104.01895981091;73930;74122;74128.62935685395;74758;75531.4893702123;67879.66060169667;68022.63954720878;69363.3063669367;70400.64799676072;71425;7143.357097861218;7595.5442673439775;7682.231776822273;7848.744200928052;8087.191280871866;48683;51449;51815.481845181064;52350;52645.21032184444;55185.51665175157;67186;67570;67714.66142669255;68440.31559684538;10795.352278863293;10890.019898209199;10946.781064378509;11136.331820090496;11282.7743445129;10247.84628230592;12025.518979240733;12175.14773965814;12325.97251385757;12648.367581621067;11348;11374.601888933848;11528.942355288505;11630;11870.406479676154;11420;11624.593139240085;11723.35521546323;11945.880541194478;12410.069244806857;10877.619283325046;10949.233553651487;11059.834102488308;11081.833772493257;12094.153409261267;8372.372072094495;8581.313494920267;8928.04989728501;9439.244860411289;9816.460094694861;8769.912300877164;9091.409058411182;9255.490947997925;9309.953450232706;9539.618415263589 13:38:39 INFO - PROCESS | 1662 | __end_tp_report 13:38:39 INFO - PROCESS | 1662 | __start_cc_report 13:38:39 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1172 13:38:39 INFO - PROCESS | 1662 | __end_cc_report 13:38:39 INFO - PROCESS | 1662 | __startTimestamp1456954719924__endTimestamp 13:38:39 INFO - PROCESS | 1662 | 13:38:39 INFO - PROCESS | 1662 | ------- Summary: start ------- 13:38:39 INFO - PROCESS | 1662 | Number of tests: 6 13:38:39 INFO - PROCESS | 1662 | 13:38:39 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5652.62 Median:5826.24 stddev:639.12 (11.0%) stddev-sans-first:613.57 13:38:39 INFO - PROCESS | 1662 | Values: 3287.7 3357.3 3384.6 3472.7 3494.4 5416.1 5462.2 5633.9 5637.9 5643.4 5620.7 5624.6 5661.9 5751.9 5757.7 5071.6 5102.2 5124.7 5144.7 5239.9 5191.0 5201.2 5240.8 5266.1 5299.4 4219.8 5102.5 5162.5 5164.6 5174.0 5129.2 5160.4 5169.8 5209.1 5223.7 5105.6 5120.1 5137.6 5151.2 5156.6 5448.9 5542.6 5551.8 5568.5 5586.5 6087.3 6098.7 6160.9 6164.9 6170.8 6210.6 6243.2 6250.7 6252.5 6262.9 5503.4 5714.8 5718.0 5730.9 5732.6 5342.4 6264.0 6271.7 6330.9 6392.5 5958.2 6040.0 6043.9 6057.2 6063.8 6048.4 6162.0 6184.3 6192.0 6196.8 5980.8 6028.1 6053.6 6057.2 6059.7 6064.4 6066.2 6077.5 6080.9 6084.5 4779.3 4812.3 4842.7 4845.2 4871.2 4304.7 4342.0 4353.1 4381.0 4397.6 5582.2 5603.5 5604.7 5606.1 5619.7 6102.5 6115.1 6155.7 6208.9 6220.9 5550.4 5565.9 5578.4 5587.3 5603.1 4521.9 5270.4 5296.2 5298.7 5363.6 6219.9 6305.4 6378.4 6402.8 6412.9 6196.9 6200.7 6201.0 6205.5 6206.6 6349.7 6355.4 6359.3 6385.5 6391.4 5926.8 6031.3 6044.7 6100.0 6124.1 5410.6 5945.0 6168.5 6182.0 6188.7 5911.2 5942.2 5977.6 5998.6 6004.2 5849.5 5950.1 6053.3 6055.6 6097.8 5793.0 5802.6 5810.4 5813.2 5814.9 5888.1 5963.1 5964.2 5967.8 6014.8 5826.2 5832.8 5868.8 5908.4 5920.0 13:38:39 INFO - PROCESS | 1662 | 13:38:39 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:56152.32 Median:35374.15 stddev:116572.98 (329.5%) stddev-sans-first:116825.25 13:38:39 INFO - PROCESS | 1662 | Values: 549.9 573.0 575.3 591.9 632.5 37775.2 38083.6 38106.8 38112.5 38188.2 39718.2 40185.8 40263.6 40306.8 40405.6 9460.5 9685.8 9698.4 9707.0 9715.7 8244.6 9192.9 9446.1 9616.3 9621.8 9579.1 9599.0 9650.7 9662.8 9669.9 9510.9 9606.7 9628.5 9630.2 9631.5 9544.8 9696.0 9705.5 9711.5 9719.8 38980.4 39151.6 39176.0 39245.4 39314.6 3182.3 3295.6 3332.8 3696.7 3704.9 27990.4 28297.4 28581.3 28829.4 28881.7 2701.9 2706.5 2709.8 2842.0 2933.3 471973.0 473682.6 473722.0 474420.0 475239.0 43519.3 43524.6 43681.0 59002.0 59515.1 35110.8 35163.8 42813.1 42949.6 42966.8 11824.8 14425.3 14629.8 14656.3 14710.9 12130.6 12229.7 12241.3 12242.4 12251.4 14156.6 14176.9 14202.5 14233.2 14358.8 5166.6 5401.8 6263.6 6310.4 6372.8 920.5 924.3 1008.0 1076.8 1086.0 28175.0 28573.0 28721.6 28981.3 29014.1 1064.3 1068.7 1106.2 1139.2 1225.1 14371.5 14443.9 14636.6 14698.4 14787.0 503408.0 504753.0 509645.0 510004.0 510813.0 43434.3 52798.7 53930.5 54579.5 54827.0 1308.6 1336.3 1411.5 1441.2 1529.6 27725.0 27873.1 28060.6 28360.9 28433.6 39803.4 43256.1 43306.4 43329.8 43390.8 295260.0 307094.0 307374.0 307502.0 307910.0 27827.7 31637.0 31859.7 31879.8 33151.2 39869.8 40595.8 41170.8 41450.8 44255.3 33704.5 34744.6 35102.0 35359.0 35463.9 34250.7 34251.0 34820.3 35085.8 35167.6 30530.1 31292.7 31892.4 34931.7 35389.3 29485.0 30365.0 30439.7 30600.0 30742.4 23122.1 23226.1 23565.0 23675.3 23766.0 13:38:39 INFO - PROCESS | 1662 | 13:38:39 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:34657.77 Median:14383.77 stddev:104059.31 (723.4%) stddev-sans-first:104319.23 13:38:39 INFO - PROCESS | 1662 | Values: 293.9 353.3 354.4 359.9 363.7 19404.8 19873.2 20472.1 20522.7 20524.2 15502.2 16982.7 19372.0 19412.6 20272.5 5650.2 5837.0 5870.9 5873.9 5874.4 4146.0 5674.2 5712.9 5782.0 5854.9 4315.2 6118.6 6364.0 6368.6 6370.8 6089.2 6319.1 6327.3 6340.4 6371.5 5465.4 5477.5 5510.3 5516.1 5518.6 24561.6 24876.6 25598.2 26060.9 26061.1 1863.7 2091.9 2344.2 2706.5 2840.7 9505.6 9537.0 9603.3 9768.6 9813.6 1631.9 1668.6 1722.7 1726.5 1749.5 95891.0 104039.0 106684.9 109413.0 111235.9 11154.2 11162.4 11177.0 11185.9 11372.4 13592.7 13601.7 13635.5 13646.2 13661.0 8209.4 8255.5 8320.7 8442.7 8456.5 6947.6 8367.7 8384.6 8393.7 8480.4 4309.6 4386.6 4386.6 4441.3 4470.0 1711.4 1780.8 1847.4 1859.3 1868.4 803.4 843.9 903.8 905.5 1020.4 17189.7 19303.5 20015.1 20529.0 20634.7 911.9 924.0 942.7 949.4 973.6 10669.4 10952.9 10965.7 10988.3 11324.5 608340.0 625324.0 630515.8 640508.0 640894.0 107876.0 109842.0 110046.4 110113.0 112107.4 1001.2 1014.2 1015.2 1032.9 1032.9 17652.6 17765.1 17828.6 18284.9 18441.2 49855.0 49979.5 50041.2 50254.5 50977.0 72723.0 73729.3 73823.6 73975.6 74554.0 7772.8 8002.1 8036.4 8103.6 8351.7 9368.3 12168.0 12768.6 13129.7 13172.0 10898.7 11158.8 11511.9 11549.0 11553.4 10963.1 11114.2 11183.6 11345.7 11522.0 9626.8 11331.8 11607.7 11654.9 11759.2 7894.1 7909.7 8176.3 8177.5 8178.8 10430.3 11327.4 11611.6 11698.0 11722.3 13:38:39 INFO - PROCESS | 1662 | 13:38:39 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5831.25 Median:5296.31 stddev:3013.39 (56.9%) stddev-sans-first:3003.28 13:38:39 INFO - PROCESS | 1662 | Values: 1381.5 1504.4 1513.8 1746.2 1931.4 7666.6 8175.2 8329.8 8340.2 8342.2 8114.4 8194.1 8276.2 8281.5 8294.9 2115.7 2345.9 2381.1 2407.3 2410.2 2377.7 2379.9 2383.2 2386.3 2389.6 2334.8 2352.6 2375.7 2390.4 2393.0 2343.8 2377.9 2379.9 2393.9 2411.4 2321.8 2396.2 2406.1 2411.7 2417.6 8387.7 8459.8 8462.9 8477.5 8480.6 5117.3 5214.0 5224.2 5251.9 5253.4 3468.2 3547.9 3594.8 3624.0 3661.3 1026.7 1036.5 1040.4 1063.4 1067.2 9552.6 11301.9 11308.6 11320.4 11321.6 4667.5 4716.0 4738.3 4779.4 4811.9 9747.7 9751.6 9767.4 9771.7 9777.0 5256.7 5265.1 5290.4 5292.2 5300.4 4301.9 4405.6 4679.8 4745.2 4758.7 3758.9 3808.6 3813.7 3836.7 3870.8 1260.8 1267.1 1269.5 1278.9 1279.4 1316.1 1328.1 1352.2 1360.1 1361.2 7842.6 7922.0 8085.0 8107.3 8119.2 1183.6 1184.6 1197.6 1206.4 1209.7 6106.5 6149.4 6219.8 6224.0 6225.6 9841.6 10166.3 10284.5 10291.3 10362.3 9943.9 10229.8 10238.3 10258.9 10363.7 7791.7 7922.6 7969.1 8033.0 8034.4 7580.2 7591.2 7623.3 7634.0 7677.0 9013.5 9241.4 9264.4 9441.7 9453.6 9292.4 9552.8 9559.0 9612.7 9655.2 6519.6 6702.5 6711.1 7177.6 7285.4 7201.2 7914.3 7935.8 7944.9 7951.8 6940.7 7005.5 7033.6 7149.4 7171.9 6930.3 6959.5 7019.8 7066.9 7097.9 6411.2 7208.3 7413.6 7523.3 7536.7 6839.7 6841.7 6889.2 6904.8 6910.4 6910.5 6971.1 6979.5 7001.2 7029.5 13:38:39 INFO - PROCESS | 1662 | 13:38:39 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5727.46 Median:6541.46 stddev:1838.18 (28.1%) stddev-sans-first:1797.68 13:38:39 INFO - PROCESS | 1662 | Values: 303.2 305.3 309.8 312.4 314.9 6503.1 6613.4 6665.1 6699.5 6709.1 6604.0 6657.2 6697.3 6702.3 6720.0 3815.3 4591.8 4704.0 4847.2 4876.3 4828.0 4834.2 4844.4 4858.1 4865.7 4787.2 4795.9 4820.6 4824.6 4830.5 3972.4 4578.7 4711.9 4813.6 4833.6 3579.3 4115.5 4127.8 4140.1 4156.2 5667.4 5789.2 6336.6 6343.4 6345.9 5631.4 5649.1 5656.8 5661.2 5663.7 6992.6 6993.4 7001.2 7010.2 7011.1 4379.9 4542.8 4579.2 4581.4 4624.4 7307.2 7338.4 7350.9 7389.0 7402.0 4674.9 4683.0 4683.0 4687.8 4688.0 4751.5 4769.9 4770.6 4775.2 4776.0 5613.4 5622.2 5632.4 5640.2 5658.7 6748.4 7007.4 7036.9 7053.2 7096.4 1639.7 1652.3 1664.5 1665.3 1667.2 994.1 1035.1 1058.4 1061.0 1072.5 6316.4 6455.1 6570.7 6583.4 6600.4 6300.4 7119.4 7320.0 7328.6 7329.7 6511.8 6518.2 6530.8 6552.1 6559.6 3836.5 3851.2 3884.8 3893.6 3895.9 6199.4 7689.2 7695.7 7701.5 7722.2 6204.0 7486.0 7591.1 7600.8 7606.4 5427.9 7651.9 7669.2 7673.5 7699.0 6989.6 7332.2 7332.3 7346.0 7361.2 7218.7 7228.6 7239.4 7242.9 7253.1 7625.5 7629.3 7658.2 7665.3 7668.8 4712.6 4715.9 4717.4 4724.6 4733.1 6986.5 7296.0 7302.9 7307.9 7315.5 7034.2 7063.7 7067.7 7071.5 7113.9 6079.5 6681.8 7025.8 7028.0 7040.2 6857.3 6862.3 6866.1 6873.6 6883.9 6713.7 7066.4 7070.9 7082.3 7084.8 5504.3 6634.2 6824.9 6873.2 6961.5 13:38:39 INFO - PROCESS | 1662 | 13:38:39 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18339.13 Median:629.40 stddev:26034.65 (4136.4%) stddev-sans-first:26073.72 13:38:39 INFO - PROCESS | 1662 | Values: 630.5 676.5 728.8 749.8 781.7 14661.3 14809.0 14833.7 14866.6 14866.8 15311.1 15709.8 15725.1 15786.8 15840.5 695.1 699.1 833.7 841.2 845.1 849.3 860.7 861.4 861.8 861.8 901.0 901.1 901.5 901.6 904.0 725.0 732.3 879.3 897.2 902.4 661.0 661.1 663.0 663.4 663.5 14833.5 14915.5 14928.3 14943.0 14947.0 12234.4 12350.0 12378.1 12478.2 12538.4 9891.9 10008.1 10025.9 10061.1 10364.6 3429.9 3457.6 3491.8 3515.2 3573.9 67802.3 87853.7 87978.0 89081.0 89159.0 9120.1 9166.9 9379.0 9415.5 9585.5 20643.8 20644.9 20670.1 20685.2 20959.5 7511.8 7558.8 7574.6 7733.5 7873.6 4060.5 4092.8 4115.9 4129.6 4169.1 3479.5 3517.8 3547.2 3550.0 3550.6 628.3 644.8 649.7 659.7 672.2 570.3 572.8 588.3 596.6 605.9 7900.6 8057.1 8100.4 8120.4 8323.5 488.2 561.5 586.4 591.9 598.1 3774.3 3782.6 3787.9 3843.9 4038.5 94721.0 95960.0 96826.5 98093.0 98104.0 73930.0 74122.0 74128.6 74758.0 75531.5 67879.7 68022.6 69363.3 70400.6 71425.0 7143.4 7595.5 7682.2 7848.7 8087.2 48683.0 51449.0 51815.5 52350.0 52645.2 55185.5 67186.0 67570.0 67714.7 68440.3 10795.4 10890.0 10946.8 11136.3 11282.8 10247.8 12025.5 12175.1 12326.0 12648.4 11348.0 11374.6 11528.9 11630.0 11870.4 11420.0 11624.6 11723.4 11945.9 12410.1 10877.6 10949.2 11059.8 11081.8 12094.2 8372.4 8581.3 8928.0 9439.2 9816.5 8769.9 9091.4 9255.5 9310.0 9539.6 13:38:39 INFO - PROCESS | 1662 | -------- Summary: end -------- 13:38:39 INFO - PROCESS | 1662 | 13:38:40 INFO - TEST-INFO | 1662: exit 0 13:38:40 INFO - TEST-OK | dromaeo_css | took 1113752ms 13:38:40 INFO - TEST-START | kraken 13:38:40 INFO - operating with platform_type : mac_ 13:38:40 INFO - Initialising browser for kraken test... 13:38:40 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpP42Kri/profile http://localhost:49270/getInfo.html) 13:38:42 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 13:38:42 INFO - PROCESS | 1673 | colorDepth:24 13:38:42 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 13:38:42 INFO - PROCESS | 1673 | __metrics 13:38:42 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:38:42 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:38:43 INFO - TEST-INFO | 1673: exit 0 13:38:43 INFO - Browser initialized. 13:38:43 INFO - Running cycle 1/1 for kraken test... 13:38:43 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpP42Kri/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:55 INFO - PROCESS | 1675 | RSS: Main: 243609600 13:38:55 INFO - PROCESS | 1675 | 13:38:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 13:38:58 INFO - PROCESS | 1675 | RSS: Main: 288927744 13:38:58 INFO - PROCESS | 1675 | 13:39:01 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 13:39:02 INFO - PROCESS | 1675 | RSS: Main: 299565056 13:39:02 INFO - PROCESS | 1675 | 13:39:05 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 13:39:05 INFO - PROCESS | 1675 | RSS: Main: 284180480 13:39:05 INFO - PROCESS | 1675 | 13:39:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 13:39:08 INFO - PROCESS | 1675 | RSS: Main: 287657984 13:39:08 INFO - PROCESS | 1675 | 13:39:10 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:39:10 INFO - PROCESS | 1675 | RSS: Main: 286638080 13:39:10 INFO - PROCESS | 1675 | 13:39:13 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 13:39:14 INFO - PROCESS | 1675 | RSS: Main: 288468992 13:39:14 INFO - PROCESS | 1675 | 13:39:17 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 13:39:17 INFO - PROCESS | 1675 | RSS: Main: 286625792 13:39:17 INFO - PROCESS | 1675 | 13:39:20 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 13:39:21 INFO - PROCESS | 1675 | RSS: Main: 287100928 13:39:21 INFO - PROCESS | 1675 | 13:39:22 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:39:23 INFO - PROCESS | 1675 | RSS: Main: 322621440 13:39:23 INFO - PROCESS | 1675 | 13:39:24 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:39:25 INFO - PROCESS | 1675 | RSS: Main: 321380352 13:39:25 INFO - PROCESS | 1675 | 13:39:27 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:39:28 INFO - PROCESS | 1675 | RSS: Main: 329715712 13:39:28 INFO - PROCESS | 1675 | 13:39:30 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:39:31 INFO - PROCESS | 1675 | RSS: Main: 332275712 13:39:31 INFO - PROCESS | 1675 | 13:39:33 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:39:34 INFO - PROCESS | 1675 | RSS: Main: 331427840 13:39:34 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 13:39:36 INFO - PROCESS | 1675 | RSS: Main: 391966720 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | __start_tp_report 13:39:36 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 13:39:36 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 13:39:36 INFO - PROCESS | 1675 | |i|pagename|runs| 13:39:36 INFO - PROCESS | 1675 | |0;ai-astar;111;108;112;110;92;150;162;149;133;109 13:39:36 INFO - PROCESS | 1675 | |1;audio-beat-detection;157;122;141;161;118;142;149;121;178;145 13:39:36 INFO - PROCESS | 1675 | |2;audio-dft;186;185;187;185;187;186;182;182;183;180 13:39:36 INFO - PROCESS | 1675 | |3;audio-fft;79;73;84;77;55;57;57;77;75;56 13:39:36 INFO - PROCESS | 1675 | |4;audio-oscillator;96;90;127;80;77;86;111;75;79;111 13:39:36 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;90;86;90;88;90;87;91;88;91;87 13:39:36 INFO - PROCESS | 1675 | |6;imaging-darkroom;95;95;95;96;95;95;94;96;95;95 13:39:36 INFO - PROCESS | 1675 | |7;imaging-desaturate;95;143;85;84;85;87;87;85;84;84 13:39:36 INFO - PROCESS | 1675 | |8;json-parse-financial;56;54;52;52;54;52;54;62;55;52 13:39:36 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;67;67;69;76;71;68;68;69;68;68 13:39:36 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;83;83;83;83;82;82;82;89;92;107 13:39:36 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;123;126;123;129;119;125;121;127;124;120 13:39:36 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;131;134;140;137;187;161;138;138;138;146 13:39:36 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;66;66;67;66;67;69;66;67;66;65 13:39:36 INFO - PROCESS | 1675 | __end_tp_report 13:39:36 INFO - PROCESS | 1675 | __start_cc_report 13:39:36 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1199 13:39:36 INFO - PROCESS | 1675 | __end_cc_report 13:39:36 INFO - PROCESS | 1675 | __startTimestamp1456954776509__endTimestamp 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | ------- Summary: start ------- 13:39:36 INFO - PROCESS | 1675 | Number of tests: 14 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:123.60 Median:141.00 stddev:23.19 (16.4%) stddev-sans-first:24.14 13:39:36 INFO - PROCESS | 1675 | Values: 111.0 108.0 112.0 110.0 92.0 150.0 162.0 149.0 133.0 109.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:147.00 stddev:19.26 (13.1%) stddev-sans-first:19.79 13:39:36 INFO - PROCESS | 1675 | Values: 157.0 122.0 141.0 161.0 118.0 142.0 149.0 121.0 178.0 145.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.50 stddev:2.41 (1.3%) stddev-sans-first:2.47 13:39:36 INFO - PROCESS | 1675 | Values: 186.0 185.0 187.0 185.0 187.0 186.0 182.0 182.0 183.0 180.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:69.00 Median:76.00 stddev:11.34 (14.9%) stddev-sans-first:11.44 13:39:36 INFO - PROCESS | 1675 | Values: 79.0 73.0 84.0 77.0 55.0 57.0 57.0 77.0 75.0 56.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:79.50 stddev:17.69 (22.2%) stddev-sans-first:18.73 13:39:36 INFO - PROCESS | 1675 | Values: 96.0 90.0 127.0 80.0 77.0 86.0 111.0 75.0 79.0 111.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:90.00 stddev:1.81 (2.0%) stddev-sans-first:1.87 13:39:36 INFO - PROCESS | 1675 | Values: 90.0 86.0 90.0 88.0 90.0 87.0 91.0 88.0 91.0 87.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:39:36 INFO - PROCESS | 1675 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 94.0 96.0 95.0 95.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:91.90 Median:85.00 stddev:18.25 (21.5%) stddev-sans-first:19.33 13:39:36 INFO - PROCESS | 1675 | Values: 95.0 143.0 85.0 84.0 85.0 87.0 87.0 85.0 84.0 84.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:3.06 (5.7%) stddev-sans-first:3.18 13:39:36 INFO - PROCESS | 1675 | Values: 56.0 54.0 52.0 52.0 54.0 52.0 54.0 62.0 55.0 52.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:68.50 stddev:2.69 (3.9%) stddev-sans-first:2.74 13:39:36 INFO - PROCESS | 1675 | Values: 67.0 67.0 69.0 76.0 71.0 68.0 68.0 69.0 68.0 68.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:83.00 stddev:7.93 (9.6%) stddev-sans-first:8.31 13:39:36 INFO - PROCESS | 1675 | Values: 83.0 83.0 83.0 83.0 82.0 82.0 82.0 89.0 92.0 107.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:124.50 stddev:3.16 (2.5%) stddev-sans-first:3.35 13:39:36 INFO - PROCESS | 1675 | Values: 123.0 126.0 123.0 129.0 119.0 125.0 121.0 127.0 124.0 120.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:139.00 stddev:16.91 (12.2%) stddev-sans-first:17.16 13:39:36 INFO - PROCESS | 1675 | Values: 131.0 134.0 140.0 137.0 187.0 161.0 138.0 138.0 138.0 146.0 13:39:36 INFO - PROCESS | 1675 | 13:39:36 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 13:39:36 INFO - PROCESS | 1675 | Values: 66.0 66.0 67.0 66.0 67.0 69.0 66.0 67.0 66.0 65.0 13:39:36 INFO - PROCESS | 1675 | -------- Summary: end -------- 13:39:36 INFO - PROCESS | 1675 | 13:39:37 INFO - TEST-INFO | 1675: exit 0 13:39:37 INFO - TEST-OK | kraken | took 56793ms 13:39:37 INFO - SUITE-END | took 1170s 13:39:37 INFO - Completed test suite (00:19:30) 13:39:37 INFO - Working with test: dromaeo_css 13:39:37 INFO - Generating results file: dromaeo_css 13:39:37 INFO - Working with test: kraken 13:39:37 INFO - Generating results file: kraken 13:39:37 INFO - javascript benchmark 13:39:37 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:39:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 13:39:38 INFO - process_Request line: dromaeo_css 7358.44 graph.html#tests=[[72,64,59]] 13:39:38 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:39:38 INFO - process_Request line: kraken 1434.50 graph.html#tests=[[232,64,59]] 13:39:38 INFO - RETURN: dromaeo_css: 7358.44 13:39:38 INFO - RETURN: kraken: 1434.50 13:39:38 INFO - javascript benchmark 13:39:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3287.6547962463933, 3357.261402491452, 3384.6107697614766, 3472.6700963408484, 3494.405950988332, 5416.133418653007, 5462.180672899062, 5633.915491267634, 5637.943620563793, 5643.379228284885, 5620.690862002588, 5624.634398764088, 5661.886762264752, 5751.884962300762, 5757.654540727559, 5071.594272458213, 5102.234664800291, 5124.718140502271, 5144.6655967362, 5239.947600523984, 5191.0, 5201.2458193561915, 5240.842774716764, 5266.131088370415, 5299.364076310848, 4219.839544125375, 5102.515261050195, 5162.457941916082, 5164.6384753067305, 5174.0, 5129.153689641204, 5160.432352441228, 5169.793208271664, 5209.062368773619, 5223.686578805284, 5105.642605017651, 5120.078385890538, 5137.614678899097, 5151.150060240094, 5156.613254005964, 5448.945510544923, 5542.63972841764, 5551.750171242304, 5568.52667523261, 5586.525145362649, 6087.3303936566945, 6098.664573448458, 6160.938390616081, 6164.938350616526, 6170.7531698732, 6210.627362358273, 6243.219597550306, 6250.718717657671, 6252.499800015988, 6262.937370626281, 5503.394626591072, 5714.771409143629, 5718.0, 5730.914036289418, 5732.570057245724, 5342.412334643186, 6263.96868015657, 6271.686415679198, 6330.873382532323, 6392.4566411854585, 5958.195643588147, 6040.0, 6043.8791224175275, 6057.212562366953, 6063.7574497020505, 6048.425399587032, 6162.044883043135, 6184.319724830265, 6192.040233763774, 6196.783112591128, 5980.790672326448, 6028.065649824284, 6053.576249662569, 6057.18228039209, 6059.666718330446, 6064.363241859542, 6066.150738896558, 6077.483413909778, 6080.939190608037, 6084.452399283997, 4779.283107533898, 4812.25410061441, 4842.685225460405, 4845.152098382769, 4871.244957031666, 4304.677149213821, 4342.0, 4353.107612939403, 4380.9780951095045, 4397.648188144941, 5582.218489411485, 5603.467670571289, 5604.6917419541505, 5606.074997625346, 5619.690916999522, 6102.542309326818, 6115.118650813375, 6155.72299246535, 6208.875822483525, 6220.937790622036, 5550.361708403505, 5565.888682226414, 5578.358488773762, 5587.27365442498, 5603.131514615241, 4521.864344069683, 5270.393904700932, 5296.179092240709, 5298.735063246822, 5363.597730170253, 6219.906701399483, 6305.432511074117, 6378.425941665272, 6402.807915762534, 6412.935870641234, 6196.876062478816, 6200.689965501617, 6201.0, 6205.5345849062405, 6206.627602343874, 6349.6507692077375, 6355.396237357444, 6359.268684101203, 6385.45723613498, 6391.424771770563, 5926.822195334147, 6031.336552979256, 6044.697765111815, 6099.975683468331, 6124.14262003311, 5410.621256512007, 5944.959632064285, 6168.537359697951, 6182.041783523561, 6188.659623720739, 5911.231539899785, 5942.183620354301, 5977.641341519523, 5998.610090344114, 6004.249468816398, 5849.473547380756, 5950.137230101697, 6053.334133245251, 6055.576109672457, 6097.817065488042, 5792.986227410102, 5802.564807639359, 5810.448007439287, 5813.215215945962, 5814.912776308443, 5888.057910734262, 5963.135345374983, 5964.194833697569, 5967.76128954837, 6014.789482368096, 5826.242588463472, 5832.766689332549, 5868.765249390148, 5908.350081490947, 5920.0], "unit": "score", "name": "dojo.html", "value": 5612.35104036411}, {"lowerIsBetter": false, "replicates": [549.8645297460746, 573.0001147996744, 575.3113084031767, 591.9200907877437, 632.5161251642493, 37775.244495110084, 38083.619163808355, 38106.80946595267, 38112.47550097996, 38188.236235275275, 39718.205635887265, 40185.79442616719, 40263.59736402635, 40306.79079627609, 40405.59594404055, 9460.526973651307, 9685.806283874354, 9698.418094914292, 9706.980767019468, 9715.70852874415, 8244.628991695357, 9192.908070919306, 9446.102620251066, 9616.27877909156, 9621.759456013586, 9579.137877591016, 9599.04009599038, 9650.71047868565, 9662.806743865154, 9669.903300967006, 9510.857337139949, 9606.711798646053, 9628.47043412612, 9630.229581633523, 9631.470269135194, 9544.761380965532, 9695.951520242354, 9705.466199359033, 9711.494718318672, 9719.805603887882, 38980.41529377062, 39151.60848391536, 39176.020599485244, 39245.41131883024, 39314.60685393138, 3182.315802102536, 3295.5880514935634, 3332.766706330558, 3696.704263658901, 3704.85180592776, 27990.440191196267, 28297.434051319065, 28581.28546786326, 28829.42341153165, 28881.711182888113, 2701.91894243173, 2706.512827691015, 2709.76705598952, 2842.0337085391066, 2933.281346070205, 471973.0, 473682.6315868433, 473722.0, 474420.0, 475239.0, 43519.34720979188, 43524.56475435205, 43681.0, 59002.0, 59515.10727339093, 35110.82444587761, 35163.82418087893, 42813.14373712508, 42949.57050429518, 42966.78516607397, 11824.76350473003, 14425.278736063156, 14629.78055329171, 14656.267186640625, 14710.852891470948, 12130.575429859913, 12229.694257643452, 12241.265524068407, 12242.44908979098, 12251.387430628432, 14156.575302740934, 14176.858231417555, 14202.502912398017, 14233.217173055375, 14358.784618230735, 5166.61250406221, 5401.783928642889, 6263.561550691499, 6310.368963103653, 6372.845441506392, 920.4661296448044, 924.2882980105416, 1007.9647212347533, 1076.7603384959266, 1085.9511321990371, 28175.0, 28573.0, 28721.56917646237, 28981.275468113465, 29014.12957611275, 1064.2816099133054, 1068.6793961811582, 1106.2090605217309, 1139.2196345503357, 1225.08730995409, 14371.496997605034, 14443.92778036124, 14636.634084147981, 14698.412063517553, 14787.0, 503408.0, 504753.0, 509645.0, 510004.0, 510813.0, 43434.34848477212, 52798.73600632049, 53930.460695393325, 54579.454205458234, 54827.0, 1308.5943357559188, 1336.2717319061135, 1411.527138408624, 1441.1857300625113, 1529.62524181574, 27725.0, 27873.08061420326, 28060.579091313237, 28360.85819570889, 28433.573496397155, 39803.40294895637, 43256.13487730291, 43306.35040474332, 43329.783351083046, 43390.783046084565, 295260.0, 307094.0, 307374.0, 307502.0, 307910.0, 27827.721722782513, 31637.0, 31859.68140318567, 31879.840600796848, 33151.171220719676, 39869.80390588287, 40595.78212653625, 41170.794146029075, 41450.79274603607, 44255.336169956834, 33704.494432583044, 34744.6102155921, 35102.0, 35359.0, 35463.936081917585, 34250.65749342475, 34250.97247082592, 34820.30359392747, 35085.82457087698, 35167.648323516434, 30530.057988751654, 31292.68707312898, 31892.362152756352, 34931.650683493855, 35389.292214156085, 29485.0, 30365.0, 30439.695603043685, 30600.0, 30742.38515229638, 23122.06865893792, 23226.070957161523, 23565.0, 23675.289741307788, 23766.049358025484], "unit": "score", "name": "ext.html", "value": 18224.08749906795}, {"lowerIsBetter": false, "replicates": [293.8971360023991, 353.29693909120857, 354.43487876155126, 359.8560575769692, 363.65271166036405, 19404.78805183396, 19873.20507179713, 20472.07875645594, 20522.692159617618, 20524.179032838667, 15502.224888755574, 16982.745258821098, 19372.031398430056, 19412.611747765073, 20272.493187670316, 5650.208970744099, 5837.036888913324, 5870.9119363209375, 5873.941260587403, 5874.441928016831, 4146.046409325857, 5674.233978412903, 5712.857178570527, 5782.0, 5854.882902341972, 4315.223259813232, 6118.63288202707, 6364.0, 6368.5860419072615, 6370.840728981766, 6089.177960975256, 6319.083732858733, 6327.303996560375, 6340.397662222082, 6371.458426033792, 5465.426130256305, 5477.5070243677865, 5510.283663123809, 5516.062269414209, 5518.641288316287, 24561.631575526382, 24876.626850597255, 25598.23205303844, 26060.8696956514, 26061.08786192493, 1863.6738570750065, 2091.8612901465117, 2344.2498400511845, 2706.458708258356, 2840.701726318748, 9505.572249248731, 9536.952315238448, 9603.32776705631, 9768.560414781352, 9813.607455701764, 1631.9428819991363, 1668.5578321744747, 1722.7243641017376, 1726.5079452356144, 1749.5101371615967, 95891.0, 104039.0, 106684.93315066828, 109413.0, 111235.88764112337, 11154.219204655596, 11162.386068766296, 11177.0, 11185.944070279596, 11372.374519401512, 13592.728145437035, 13601.727965440834, 13635.454581816815, 13646.181229126285, 13661.0, 8209.425340226127, 8255.504669719836, 8320.70877519284, 8442.704505342406, 8456.450330728483, 6947.617881016593, 8367.748967530863, 8384.622691978875, 8393.664253429795, 8480.448770829877, 4309.59058889405, 4386.627136693353, 4386.627136693417, 4441.311596702516, 4469.9776501117285, 1711.3582406597525, 1780.8041115477288, 1847.4272975377676, 1859.2934684819681, 1868.392772348992, 803.3573141486787, 843.8649816029529, 903.823754367892, 905.4748246017294, 1020.3979652005353, 17189.7421538677, 19303.51741206453, 20015.09932053061, 20528.973551322673, 20634.690479642817, 911.9498427586414, 923.9676611318572, 942.673892507339, 949.4208532794989, 973.6446197138135, 10669.41318227505, 10952.890471095347, 10965.725856853483, 10988.28576142564, 11324.508608106204, 608340.0, 625324.0, 630515.84742076, 640508.0, 640894.0, 107876.0, 109842.0, 110046.44976775224, 110113.0, 112107.43946280217, 1001.249063202598, 1014.2342531388902, 1015.2487159501916, 1032.850236715672, 1032.8812186598486, 17652.558686032953, 17765.11174441247, 17828.55428614295, 18284.908575457037, 18441.24808143224, 49855.0, 49979.50020499749, 50041.24938126004, 50254.49745502498, 50976.98046039133, 72723.0, 73729.26270737438, 73823.63088184525, 73975.6301218512, 74554.0, 7772.805679858049, 8002.07976082758, 8036.357091432555, 8103.635336409993, 8351.749447516584, 9368.250539956924, 12167.965722913297, 12768.61694149177, 13129.671758206121, 13172.0, 10898.727531811768, 11158.832617510907, 11511.884881151416, 11549.018333441416, 11553.364564949008, 10963.122950164126, 11114.22200445961, 11183.608573700207, 11345.6767320778, 11522.0, 9626.807463850824, 11331.773364532828, 11607.6517704469, 11654.941725291319, 11759.235649683085, 7894.1316455188735, 7909.683612655429, 8176.305014073632, 8177.4684645497855, 8178.7955301117945, 10430.322029068086, 11327.376994265394, 11611.593594224161, 11698.0, 11722.296662200295], "unit": "score", "name": "jquery.html", "value": 9312.431213468239}, {"lowerIsBetter": false, "replicates": [1381.4543255414105, 1504.3982407037183, 1513.8107736532936, 1746.1792957310067, 1931.362650325392, 7666.578338191404, 8175.182481751822, 8329.791755206123, 8340.165983401657, 8342.249197572217, 8114.431989760719, 8194.057683366414, 8276.213759692835, 8281.503109813415, 8294.921660184184, 2115.6614941609346, 2345.9178928737497, 2381.1070848431796, 2407.3018824540864, 2410.18053861687, 2377.6552399902002, 2379.8929048192786, 2383.2492764779126, 2386.260259319608, 2389.629607410854, 2334.7898689117974, 2352.5882970480184, 2375.6674065630827, 2390.3785015895905, 2392.9760702393014, 2343.7890589846997, 2377.857328560292, 2379.9048038078454, 2393.8803059847023, 2411.397150712322, 2321.837471376987, 2396.221228100874, 2406.097713357491, 2411.6985376827897, 2417.613181890889, 8387.664493420256, 8459.83080338396, 8462.915370846275, 8477.533735644538, 8480.575971201477, 5117.309163262949, 5213.983273261715, 5224.216367544898, 5251.921221181686, 5253.3958594761325, 3468.219650578625, 3547.94678079829, 3594.802285874276, 3624.039629498185, 3661.286049220403, 1026.6560702164784, 1036.461040259061, 1040.4121671255716, 1063.3566692151214, 1067.2315932528568, 9552.57013434397, 11301.943490282578, 11308.604198853083, 11320.433978301053, 11321.603743869007, 4667.463241727177, 4715.952840471551, 4738.265568836836, 4779.378680771478, 4811.879703007383, 9747.707568772948, 9751.561179746928, 9767.365121267096, 9771.706848794547, 9777.0, 5256.737163141827, 5265.052290587654, 5290.365156181283, 5292.179712144623, 5300.44345343741, 4301.935470967938, 4405.625521830616, 4679.812807487662, 4745.240761478216, 4758.690685105457, 3758.8872333830027, 3808.638179372955, 3813.7139714521522, 3836.712246581518, 3870.787106709102, 1260.8171815086762, 1267.1193520503161, 1269.5112381732915, 1278.9232646041266, 1279.366713476835, 1316.0787448785889, 1328.0504439325928, 1352.1684164238923, 1360.1363134409721, 1361.2104979112091, 7842.5686587237105, 7922.049354077432, 8084.959575202086, 8107.310878575269, 8119.228673276029, 1183.6153250193722, 1184.5735535207318, 1197.6347214099783, 1206.3666575048169, 1209.7459533498063, 6106.480949119375, 6149.385061493905, 6219.813405597839, 6223.96888015566, 6225.595336303217, 9841.55712992917, 10166.339187952759, 10284.485775711184, 10291.279610427348, 10362.274640775224, 9943.900560994442, 10229.795404092025, 10238.33450825694, 10258.897411025944, 10363.740906477398, 7791.688332466638, 7922.643481043367, 7969.083555391204, 8033.0, 8034.357251419872, 7580.204078571891, 7591.240875912365, 7623.313901748869, 7634.007579014693, 7677.0, 9013.504257265913, 9241.445513269226, 9264.39781414206, 9441.716748497556, 9453.621855125994, 9292.442453452815, 9552.755102551035, 9559.0, 9612.711618651172, 9655.227581793299, 6519.641419721771, 6702.463802895659, 6711.12755341822, 7177.605231712306, 7285.417166626551, 7201.171865235565, 7914.287714105758, 7935.761927141964, 7944.880826787487, 7951.761447156595, 6940.652967351713, 7005.509614326948, 7033.648317584202, 7149.356557909813, 7171.856562868609, 6930.306969303029, 6959.478039146983, 7019.789406317818, 7066.929330706833, 7097.893531596927, 6411.198600174978, 7208.27917208275, 7413.592252426169, 7523.3229009389415, 7536.660850261642, 6839.726410943506, 6841.692123854339, 6889.207741109836, 6904.758333458305, 6910.378065974087, 6910.516263861682, 6971.128608923885, 6979.511434199558, 7001.159860816734, 7029.472789540907], "unit": "score", "name": "mootools.html", "value": 4797.302151756271}, {"lowerIsBetter": false, "replicates": [303.1662926950885, 305.2582225192781, 309.84972288440105, 312.42981558655447, 314.8567401832167, 6503.057056726778, 6613.437857782088, 6665.100211471456, 6699.464042876571, 6709.060731497594, 6604.0, 6657.167854018247, 6697.2633010368945, 6702.262751097375, 6719.966400168005, 3815.3212586462005, 4591.816327346902, 4703.952960470386, 4847.151748444017, 4876.317315575804, 4827.975860120694, 4834.154023045953, 4844.442889067749, 4858.1012512685265, 4865.732384718839, 4787.210110331791, 4795.928061079087, 4820.6143508519235, 4824.6381521385865, 4830.454254638517, 3972.3842804365368, 4578.702384345007, 4711.882202944919, 4813.566778989908, 4833.613310935117, 3579.284143171376, 4115.52671442785, 4127.814248358831, 4140.136938377742, 4156.168766246733, 5667.4049224831215, 5789.247397838254, 6336.58812177207, 6343.429091381751, 6345.873082538324, 5631.352394474647, 5649.067903795869, 5656.773729050833, 5661.179129026268, 5663.745131469093, 6992.6154061526595, 6993.440524758007, 7001.194862590816, 7010.193827709828, 7011.123609548807, 4379.934300985487, 4542.772861356919, 4579.152856721517, 4581.358609794632, 4624.398828152319, 7307.159676637201, 7338.4496162788, 7350.889736653954, 7389.039424874785, 7401.9629901850685, 4674.929876051862, 4682.9531704683195, 4682.9765851171205, 4687.81248750053, 4687.9765601171775, 4751.52484751529, 4769.928451073168, 4770.61835053195, 4775.2359622460235, 4775.976120119447, 5613.410591887875, 5622.240997465372, 5632.352279487829, 5640.238567793295, 5658.688772117573, 6748.414122681166, 7007.4394048476, 7036.92963070373, 7053.188883278386, 7096.432285417154, 1639.6966561186218, 1652.3473228075084, 1664.4756901576206, 1665.3338664534042, 1667.1830802906488, 994.125169850527, 1035.1460045462522, 1058.396713873085, 1061.0185578340004, 1072.4798472740715, 6316.431521163117, 6455.096286519891, 6570.671466426659, 6583.374579414948, 6600.405963463311, 6300.401461861115, 7119.394851437686, 7320.0, 7328.59692716895, 7329.743458979016, 6511.772087976898, 6518.217813862272, 6530.804075877636, 6552.115464412243, 6559.6064236145985, 3836.462895194675, 3851.1527463957887, 3884.76691398517, 3893.6106389361403, 3895.8831235062426, 6199.411055949678, 7689.19263477338, 7695.692172313156, 7701.460897737216, 7722.227777222345, 6203.976343903206, 7485.962570187223, 7591.051118610174, 7600.8479830403085, 7606.429517786189, 5427.864303392446, 7651.923480765233, 7669.156392796899, 7673.462857600138, 7698.961505192438, 6989.615571143636, 7332.193458719643, 7332.340089391981, 7346.045014148127, 7361.227071157666, 7218.747343843151, 7228.602426866572, 7239.384652304613, 7242.855142897007, 7253.1296244451005, 7625.466217364731, 7629.2752188542, 7658.234176582298, 7665.3101220890385, 7668.769936901902, 4712.59942904857, 4715.93891374438, 4717.410323709536, 4724.598409135262, 4733.100710864925, 6986.476014298846, 7296.0, 7302.9410735442, 7307.8538429232185, 7315.524490908074, 7034.191068027242, 7063.71745130189, 7067.6819543119655, 7071.540349877241, 7113.893291600733, 6079.513638908965, 6681.763873683384, 7025.789226323219, 7028.0, 7040.190378106583, 6857.27998560144, 6862.3137686230975, 6866.141732283465, 6873.621950792754, 6883.8967415487805, 6713.731450741916, 7066.364027237573, 7070.893936591058, 7082.256363081802, 7084.752033678797, 5504.256925315031, 6634.2087636336955, 6824.863502729819, 6873.243943166148, 6961.547499412522], "unit": "score", "name": "prototype.html", "value": 5107.54196206017}, {"lowerIsBetter": false, "replicates": [630.4515071887458, 676.5129107042928, 728.7813655903229, 749.7863109013932, 781.718581310728, 14661.340239689212, 14809.0, 14833.703325933475, 14866.55400337989, 14866.77699834502, 15311.081335119901, 15709.764353534678, 15725.135117568529, 15786.84213157868, 15840.524784256491, 695.1241435790914, 699.0876905638165, 833.679033572076, 841.2176675691604, 845.137959281534, 849.2611428057598, 860.7245681381929, 861.4271509446243, 861.7543999960012, 861.8491763941286, 901.0358915959926, 901.0673952459206, 901.4771432569127, 901.5807649443008, 903.9819203615924, 724.9746258880966, 732.3116270705519, 879.3317079019927, 897.1701176411825, 902.3593248793364, 661.0150875195924, 661.137215933207, 662.9823221355244, 663.4029373563783, 663.5189487621436, 14833.480828170963, 14915.477958271409, 14928.32822522989, 14942.953993220479, 14946.953713240078, 12234.449449774782, 12350.0, 12378.133530652858, 12478.18891772041, 12538.373081345897, 9891.851622225673, 10008.099271065566, 10025.89974100257, 10061.14480269178, 10364.637237696645, 3429.879954201616, 3457.550518432613, 3491.8254087295786, 3515.209077957439, 3573.928521429557, 67802.32197678059, 87853.68219476713, 87978.0, 89081.0, 89159.0, 9120.133587309196, 9166.86249706255, 9379.0, 9415.529223538795, 9585.520723963775, 20643.793562064187, 20644.89677551633, 20670.069846856928, 20685.17259309641, 20959.476013099793, 7511.8497630047095, 7558.811029724301, 7574.621268936641, 7733.4973226740085, 7873.566953817595, 4060.5127384714024, 4092.7544347339253, 4115.9176816464105, 4129.587041295847, 4169.145325208325, 3479.5476588043393, 3517.806520641338, 3547.2018795770746, 3550.04148879801, 3550.627184145679, 628.3496581038694, 644.8420137066355, 649.665422307512, 659.6569783712442, 672.2034389248756, 570.3070769015666, 572.8252882870764, 588.3469349022581, 596.5972968246504, 605.9333473317931, 7900.604969751489, 8057.113717491071, 8100.392470564731, 8120.3503719702285, 8323.522956282328, 488.2115383655442, 561.4553882733742, 586.4370204603629, 591.914172444993, 598.0909018292172, 3774.301754175486, 3782.6406491383273, 3787.9431808522895, 3843.9237013636225, 4038.495188101487, 94721.0, 95960.0, 96826.51586742162, 98093.0, 98104.01895981091, 73930.0, 74122.0, 74128.62935685395, 74758.0, 75531.4893702123, 67879.66060169667, 68022.63954720878, 69363.3063669367, 70400.64799676072, 71425.0, 7143.357097861218, 7595.5442673439775, 7682.231776822273, 7848.744200928052, 8087.191280871866, 48683.0, 51449.0, 51815.481845181064, 52350.0, 52645.21032184444, 55185.51665175157, 67186.0, 67570.0, 67714.66142669255, 68440.31559684538, 10795.352278863293, 10890.019898209199, 10946.781064378509, 11136.331820090496, 11282.7743445129, 10247.84628230592, 12025.518979240733, 12175.14773965814, 12325.97251385757, 12648.367581621067, 11348.0, 11374.601888933848, 11528.942355288505, 11630.0, 11870.406479676154, 11420.0, 11624.593139240085, 11723.35521546323, 11945.880541194478, 12410.069244806857, 10877.619283325046, 10949.233553651487, 11059.834102488308, 11081.833772493257, 12094.153409261267, 8372.372072094495, 8581.313494920267, 8928.04989728501, 9439.244860411289, 9816.460094694861, 8769.912300877164, 9091.409058411182, 9255.490947997925, 9309.953450232706, 9539.618415263589], "unit": "score", "name": "yui.html", "value": 6801.743801400629}], "name": "dromaeo_css", "value": 7358.444504121962}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 112.0, 110.0, 92.0, 150.0, 162.0, 149.0, 133.0, 109.0], "unit": "score", "name": "ai-astar", "value": 123.6}, {"lowerIsBetter": true, "replicates": [157.0, 122.0, 141.0, 161.0, 118.0, 142.0, 149.0, 121.0, 178.0, 145.0], "unit": "score", "name": "audio-beat-detection", "value": 143.4}, {"lowerIsBetter": true, "replicates": [186.0, 185.0, 187.0, 185.0, 187.0, 186.0, 182.0, 182.0, 183.0, 180.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [79.0, 73.0, 84.0, 77.0, 55.0, 57.0, 57.0, 77.0, 75.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.0}, {"lowerIsBetter": true, "replicates": [96.0, 90.0, 127.0, 80.0, 77.0, 86.0, 111.0, 75.0, 79.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 93.2}, {"lowerIsBetter": true, "replicates": [90.0, 86.0, 90.0, 88.0, 90.0, 87.0, 91.0, 88.0, 91.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 95.1}, {"lowerIsBetter": true, "replicates": [95.0, 143.0, 85.0, 84.0, 85.0, 87.0, 87.0, 85.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 91.9}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 52.0, 52.0, 54.0, 52.0, 54.0, 62.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 76.0, 71.0, 68.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 83.0, 82.0, 82.0, 82.0, 89.0, 92.0, 107.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [123.0, 126.0, 123.0, 129.0, 119.0, 125.0, 121.0, 127.0, 124.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [131.0, 134.0, 140.0, 137.0, 187.0, 161.0, 138.0, 138.0, 138.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 66.0, 67.0, 69.0, 66.0, 67.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1434.5}]} 13:39:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1434.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7358.44"}}} 13:39:38 INFO - Return code: 0 13:39:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:39:38 INFO - # TBPL SUCCESS # 13:39:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:39:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:39:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:39:38 INFO - 2016-03-02 13:39:38.361 screenresolution[1679:10028] starting screenresolution argv=screenresolution get 13:39:38 INFO - 2016-03-02 13:39:38.363 screenresolution[1679:10028] Display 0: 1600x1200x32@60 13:39:38 INFO - 2016-03-02 13:39:38.369 screenresolution[1680:10031] starting screenresolution argv=screenresolution list 13:39:38 INFO - Available Modes on Display 0 13:39:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:39:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:39:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:39:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:39:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:39:38 INFO - Intel Iris: 13:39:38 INFO - Chipset Model: Intel Iris 13:39:38 INFO - Type: GPU 13:39:38 INFO - Bus: Built-In 13:39:38 INFO - VRAM (Dynamic, Max): 1536 MB 13:39:38 INFO - Vendor: Intel (0x8086) 13:39:38 INFO - Device ID: 0x0a2e 13:39:38 INFO - Revision ID: 0x0009 13:39:38 INFO - Displays: 13:39:38 INFO - Display: 13:39:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:39:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:39:38 INFO - Display Serial Number: 1600x1200 60 13:39:38 INFO - Main Display: Yes 13:39:38 INFO - Mirror: Off 13:39:38 INFO - Online: Yes 13:39:38 INFO - Rotation: Supported 13:39:38 INFO - Return code: 0 13:39:38 INFO - Running post-action listener: _resource_record_post_action 13:39:38 INFO - Running post-run listener: _resource_record_post_run 13:39:39 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39454208; Write bytes: 703462912; Read time: 421; Write time: 2176 13:39:39 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 386281984; Write bytes: 380049408; Read time: 29510; Write time: 664 13:39:39 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 38499840; Write bytes: 300066304; Read time: 406; Write time: 1458 13:39:39 INFO - Running post-run listener: _upload_blobber_files 13:39:39 INFO - Blob upload gear active. 13:39:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:39:39 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 13:39:39 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'] 13:39:39 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 13:39:40 INFO - (blobuploader) - INFO - Open directory for files ... 13:39:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:39:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:39:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:41 INFO - (blobuploader) - INFO - Done attempting. 13:39:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:39:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:39:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:42 INFO - (blobuploader) - INFO - Done attempting. 13:39:42 INFO - (blobuploader) - INFO - Iteration through files over. 13:39:42 INFO - Return code: 0 13:39:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:39:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:39:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82e49fa6732102e14b5ddf84ac5403651a96eb9dda3d23554f73205f1123a6f84a399c80a41fc39bd21d211cd4f7d6f3f1328132b8732fa115932c6538ee4bb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b84cb6405952e98a3ba9f8834436e19d716243649ee904f789a627036d4a9e8b25cef32ecbf94f7b0a88ed8b80e3f0f4fa482568ed86782d66992732feb9a55"} 13:39:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:39:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:39:42 INFO - Contents: 13:39:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82e49fa6732102e14b5ddf84ac5403651a96eb9dda3d23554f73205f1123a6f84a399c80a41fc39bd21d211cd4f7d6f3f1328132b8732fa115932c6538ee4bb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b84cb6405952e98a3ba9f8834436e19d716243649ee904f789a627036d4a9e8b25cef32ecbf94f7b0a88ed8b80e3f0f4fa482568ed86782d66992732feb9a55"} 13:39:42 INFO - Running post-run listener: copy_logs_to_upload_dir 13:39:42 INFO - Copying logs to upload dir... 13:39:42 INFO - mkdir: /builds/slave/test/build/upload/logs 13:39:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.670415 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-02 13:39:42.682988) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 13:39:42.686360) ========= 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.wBlQrHxtOp/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.35UAgjIjVu/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82e49fa6732102e14b5ddf84ac5403651a96eb9dda3d23554f73205f1123a6f84a399c80a41fc39bd21d211cd4f7d6f3f1328132b8732fa115932c6538ee4bb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b84cb6405952e98a3ba9f8834436e19d716243649ee904f789a627036d4a9e8b25cef32ecbf94f7b0a88ed8b80e3f0f4fa482568ed86782d66992732feb9a55"} build_url:https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011005 build_url: 'https://queue.taskcluster.net/v1/task/DjmknHn5SPGOG6CLsQeTOQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82e49fa6732102e14b5ddf84ac5403651a96eb9dda3d23554f73205f1123a6f84a399c80a41fc39bd21d211cd4f7d6f3f1328132b8732fa115932c6538ee4bb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b84cb6405952e98a3ba9f8834436e19d716243649ee904f789a627036d4a9e8b25cef32ecbf94f7b0a88ed8b80e3f0f4fa482568ed86782d66992732feb9a55"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 13:39:42.716153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:39:42.716602) ========= 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.wBlQrHxtOp/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.35UAgjIjVu/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005152 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:39:42.768460) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 13:39:42.768833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 13:39:42.769314) ========= ========= Total master_lag: 6.03 =========