builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0161 starttime: 1456952724.3 results: success (0) buildid: 20160302120522 builduid: 124a9443e63547dfba40d2d7e7305e21 revision: a10be60e15925625be398dda0c8db1c168d7fd8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:24.299068) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:24.299469) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:24.299748) ========= 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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.005703 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:24.377599) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:24.377870) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:24.792766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:24.793053) ========= 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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.005997 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:24.838588) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:24.838860) ========= 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:05:24.839207) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:24.839540) ========= 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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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:05:24-- 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% 69.3M=0s 2016-03-02 13:05:25 (69.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.734554 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:25.601354) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:25.601884) ========= 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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.026241 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:25.668377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 13:05:25.668966) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a10be60e15925625be398dda0c8db1c168d7fd8d --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 a10be60e15925625be398dda0c8db1c168d7fd8d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1ZYDghtrRk/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.v7kKg5pyBR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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:05:25,750 truncating revision to first 12 chars 2016-03-02 13:05:25,750 Setting DEBUG logging. 2016-03-02 13:05:25,750 attempt 1/10 2016-03-02 13:05:25,750 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a10be60e1592?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 13:05:26,381 unpacking tar archive at: fx-team-a10be60e1592/testing/mozharness/ program finished with exit code 0 elapsedTime=0.881894 ========= master_lag: 0.36 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 13:05:26.906416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:26.906767) ========= echo a10be60e15925625be398dda0c8db1c168d7fd8d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a10be60e15925625be398dda0c8db1c168d7fd8d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1ZYDghtrRk/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.v7kKg5pyBR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 a10be60e15925625be398dda0c8db1c168d7fd8d program finished with exit code 0 elapsedTime=0.006253 script_repo_revision: 'a10be60e15925625be398dda0c8db1c168d7fd8d' ========= master_lag: 0.49 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:27.404047) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:27.404330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 13:05:27.436518) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-03-02 13:05:27.436791) ========= /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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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:05:27 INFO - MultiFileLogger online at 20160302 13:05:27 in /builds/slave/test 13:05:27 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:05:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:05:27 INFO - {'append_to_log': False, 13:05:27 INFO - 'base_work_dir': '/builds/slave/test', 13:05:27 INFO - 'blob_upload_branch': 'Fx-Team', 13:05:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:05:27 INFO - 'branch': 'Fx-Team', 13:05:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:05:27 INFO - 'config_files': ('talos/mac_config.py',), 13:05:27 INFO - 'default_actions': ('clobber', 13:05:27 INFO - 'read-buildbot-config', 13:05:27 INFO - 'download-and-extract', 13:05:27 INFO - 'populate-webroot', 13:05:27 INFO - 'create-virtualenv', 13:05:27 INFO - 'install', 13:05:27 INFO - 'run-tests'), 13:05:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:05:27 INFO - 'download_minidump_stackwalk': True, 13:05:27 INFO - 'download_symbols': 'ondemand', 13:05:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:05:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:05:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:05:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:05:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:05:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:05:27 INFO - 'installer_path': 'installer.exe', 13:05:27 INFO - 'log_level': 'info', 13:05:27 INFO - 'log_name': 'talos', 13:05:27 INFO - 'log_to_console': True, 13:05:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:05:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:05:27 INFO - 'opt_config_files': (), 13:05:27 INFO - 'pip_index': False, 13:05:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:05:27 INFO - 'cmd': ('bash', 13:05:27 INFO - '-c', 13:05:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:05:27 INFO - 'enabled': True, 13:05:27 INFO - 'halt_on_failure': False, 13:05:27 INFO - 'name': 'check_screen_resolution'},), 13:05:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:05:27 INFO - 'cmd': ('bash', 13:05:27 INFO - '-c', 13:05:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:05:27 INFO - 'enabled': True, 13:05:27 INFO - 'halt_on_failure': False, 13:05:27 INFO - 'name': 'check_screen_resolution'},), 13:05:27 INFO - 'run_cmd_checks_enabled': True, 13:05:27 INFO - 'sps_profile': False, 13:05:27 INFO - 'sps_profile_interval': 0, 13:05:27 INFO - 'suite': 'dromaeojs', 13:05:27 INFO - 'system_bits': '32', 13:05:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:05:27 INFO - 'title': 't-yosemite-r7-0161', 13:05:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:05:27 INFO - 'use_talos_json': True, 13:05:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:05:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:05:27 INFO - 'work_dir': 'build'} 13:05:27 INFO - ##### 13:05:27 INFO - ##### Running clobber step. 13:05:27 INFO - ##### 13:05:27 INFO - Running pre-action listener: _resource_record_pre_action 13:05:27 INFO - Running main action method: clobber 13:05:27 INFO - rmtree: /builds/slave/test/build 13:05:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:05:29 INFO - Running post-action listener: _resource_record_post_action 13:05:29 INFO - ##### 13:05:29 INFO - ##### Running read-buildbot-config step. 13:05:29 INFO - ##### 13:05:29 INFO - Running pre-action listener: _resource_record_pre_action 13:05:29 INFO - Running main action method: read_buildbot_config 13:05:29 INFO - Using buildbot properties: 13:05:29 INFO - { 13:05:29 INFO - "project": "", 13:05:29 INFO - "product": "firefox", 13:05:29 INFO - "script_repo_revision": "production", 13:05:29 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:05:29 INFO - "repository": "", 13:05:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:05:29 INFO - "buildid": "20160302120522", 13:05:29 INFO - "pgo_build": "False", 13:05:29 INFO - "basedir": "/builds/slave/test", 13:05:29 INFO - "buildnumber": 481, 13:05:29 INFO - "slavename": "t-yosemite-r7-0161", 13:05:29 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:05:29 INFO - "platform": "yosemite_r7", 13:05:29 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:05:29 INFO - "branch": "fx-team", 13:05:29 INFO - "repo_path": "integration/fx-team", 13:05:29 INFO - "revision": "a10be60e15925625be398dda0c8db1c168d7fd8d", 13:05:29 INFO - "stage_platform": "macosx64", 13:05:29 INFO - "builduid": "124a9443e63547dfba40d2d7e7305e21", 13:05:29 INFO - "slavebuilddir": "test" 13:05:29 INFO - } 13:05:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 13:05:29 INFO - Running post-action listener: _resource_record_post_action 13:05:29 INFO - ##### 13:05:29 INFO - ##### Running download-and-extract step. 13:05:29 INFO - ##### 13:05:29 INFO - Running pre-action listener: _resource_record_pre_action 13:05:29 INFO - Running main action method: download_and_extract 13:05:29 INFO - mkdir: /builds/slave/test/build/tests 13:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:29 INFO - https://queue.taskcluster.net/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:05:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 13:05:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 13:05:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/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:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/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:05:38 INFO - Downloaded 1277 bytes. 13:05:38 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 13:05:38 INFO - Using the following test package requirements: 13:05:38 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:05:38 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:05:38 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 13:05:38 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:05:38 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 13:05:38 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:05:38 INFO - u'jsshell-mac.zip'], 13:05:38 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:05:38 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 13:05:38 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:05:38 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:05:38 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 13:05:38 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:05:38 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 13:05:38 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:05:38 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 13:05:38 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:05:38 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:05:38 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 13:05:38 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:05:38 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:05:38 INFO - https://queue.taskcluster.net/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:05:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:05:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:05:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/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:05:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/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:05:40 INFO - Downloaded 17854983 bytes. 13:05:40 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:05:40 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:05:43 INFO - Return code: 0 13:05:43 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:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:43 INFO - https://queue.taskcluster.net/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:05:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:05:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:05:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/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:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/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:05:45 INFO - Downloaded 17854983 bytes. 13:05:45 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:05:45 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:05:48 INFO - Return code: 0 13:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:48 INFO - https://queue.taskcluster.net/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:05:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 13:05:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 13:05:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/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:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/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:05:50 INFO - Downloaded 10808263 bytes. 13:05:50 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:05:50 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:05:50 INFO - Return code: 0 13:05:50 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:05:50 INFO - https://queue.taskcluster.net/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:05:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:05:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:05:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 13:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1K7t3v-QUewACx8DsDbjw/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:05:54 INFO - Downloaded 110972608 bytes. 13:05:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:05:54 INFO - mkdir: /builds/slave/test/properties 13:05:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:05:54 INFO - Writing to file /builds/slave/test/properties/build_url 13:05:54 INFO - Contents: 13:05:54 INFO - build_url:https://queue.taskcluster.net/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:05:55 INFO - Running post-action listener: _resource_record_post_action 13:05:55 INFO - Running post-action listener: set_extra_try_arguments 13:05:55 INFO - ##### 13:05:55 INFO - ##### Running populate-webroot step. 13:05:55 INFO - ##### 13:05:55 INFO - Running pre-action listener: _resource_record_pre_action 13:05:55 INFO - Running main action method: populate_webroot 13:05:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:05:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:05:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:05:55 INFO - '--tppagecycles', 13:05:55 INFO - '7'], 13:05:55 INFO - 'tests': ['tsvgm']}}, 13:05:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:05:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:05:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:05:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:05:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:05:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:05:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:05:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:55 INFO - 'talos_options': ['--e10s'], 13:05:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:05:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:55 INFO - 'tests': ['damp', 'tps']}, 13:05:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:55 INFO - 'talos_options': ['--e10s'], 13:05:55 INFO - 'tests': ['damp', 'tps']}, 13:05:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:05:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:05:55 INFO - 'other': {'tests': ['a11yr', 13:05:55 INFO - 'ts_paint', 13:05:55 INFO - 'tpaint', 13:05:55 INFO - 'sessionrestore', 13:05:55 INFO - 'sessionrestore_no_auto_restore']}, 13:05:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:05:55 INFO - 'tests': ['a11yr', 13:05:55 INFO - 'ts_paint', 13:05:55 INFO - 'tpaint', 13:05:55 INFO - 'sessionrestore', 13:05:55 INFO - 'sessionrestore_no_auto_restore']}, 13:05:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:05:55 INFO - 'tests': ['a11yr', 13:05:55 INFO - 'ts_paint', 13:05:55 INFO - 'tpaint', 13:05:55 INFO - 'sessionrestore', 13:05:55 INFO - 'sessionrestore_no_auto_restore']}, 13:05:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:05:55 INFO - 'tests': ['a11yr', 13:05:55 INFO - 'ts_paint', 13:05:55 INFO - 'tpaint', 13:05:55 INFO - 'sessionrestore', 13:05:55 INFO - 'sessionrestore_no_auto_restore']}, 13:05:55 INFO - 'other_l64': {'tests': ['a11yr', 13:05:55 INFO - 'ts_paint', 13:05:55 INFO - 'tpaint', 13:05:55 INFO - 'sessionrestore', 13:05:55 INFO - 'sessionrestore_no_auto_restore']}, 13:05:55 INFO - 'other_nol64': {'tests': ['a11yr', 13:05:55 INFO - 'ts_paint', 13:05:55 INFO - 'tpaint', 13:05:55 INFO - 'sessionrestore', 13:05:55 INFO - 'sessionrestore_no_auto_restore']}, 13:05:55 INFO - 'svgr': {'tests': ['tsvgx', 13:05:55 INFO - 'tsvgr_opacity', 13:05:55 INFO - 'tart', 13:05:55 INFO - 'tscrollx', 13:05:55 INFO - 'cart']}, 13:05:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:05:55 INFO - 'tests': ['tsvgx', 13:05:55 INFO - 'tsvgr_opacity', 13:05:55 INFO - 'tart', 13:05:55 INFO - 'tscrollx', 13:05:55 INFO - 'cart']}, 13:05:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:55 INFO - 'tests': ['tp5o']}, 13:05:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:55 INFO - 'talos_options': ['--e10s'], 13:05:55 INFO - 'tests': ['tp5o']}, 13:05:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:55 INFO - 'talos_options': ['--xperf_path', 13:05:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:05:55 INFO - 'tests': ['tp5n']}, 13:05:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:55 INFO - 'talos_options': ['--e10s', 13:05:55 INFO - '--xperf_path', 13:05:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:05:55 INFO - 'tests': ['tp5n']}}, 13:05:55 INFO - 'talos.zip': {'path': '', 13:05:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:05:55 INFO - Running post-action listener: _resource_record_post_action 13:05:55 INFO - ##### 13:05:55 INFO - ##### Running create-virtualenv step. 13:05:55 INFO - ##### 13:05:55 INFO - Running pre-action listener: _resource_record_pre_action 13:05:55 INFO - Running main action method: create_virtualenv 13:05:55 INFO - Creating virtualenv /builds/slave/test/build/venv 13:05:55 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:05:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:05:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:05:55 INFO - Using real prefix '/tools/python27' 13:05:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:05:56 INFO - Installing distribute.............................................................................................................................................................................................done. 13:05:59 INFO - Installing pip.................done. 13:05:59 INFO - Return code: 0 13:05:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:05:59 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:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:59 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:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:59 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 0x10b49aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f878ac8d1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ed30>, '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 0x10b162db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b335b20>, '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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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:05:59 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:05:59 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:05:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ZYDghtrRk/Render', 13:05:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:05:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:05:59 INFO - 'HOME': '/Users/cltbld', 13:05:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:05:59 INFO - 'LOGNAME': 'cltbld', 13:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:59 INFO - 'MOZ_NO_REMOTE': '1', 13:05:59 INFO - 'NO_EM_RESTART': '1', 13:05:59 INFO - 'PAGER': '/bin/cat', 13:05:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:59 INFO - 'PWD': '/builds/slave/test', 13:05:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:05:59 INFO - 'SHELL': '/bin/bash', 13:05:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v7kKg5pyBR/Listeners', 13:05:59 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 13:05:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:05:59 INFO - 'USER': 'cltbld', 13:05:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:05:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:59 INFO - 'XPC_FLAGS': '0x0', 13:05:59 INFO - 'XPC_SERVICE_NAME': '0', 13:05:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:59 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:05:59 INFO - Cleaning up... 13:05:59 INFO - Return code: 0 13:05:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:05:59 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:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:59 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:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:59 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 0x10b49aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f878ac8d1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ed30>, '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 0x10b162db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b335b20>, '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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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:05:59 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:05:59 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:05:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ZYDghtrRk/Render', 13:05:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:05:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:05:59 INFO - 'HOME': '/Users/cltbld', 13:05:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:05:59 INFO - 'LOGNAME': 'cltbld', 13:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:59 INFO - 'MOZ_NO_REMOTE': '1', 13:05:59 INFO - 'NO_EM_RESTART': '1', 13:05:59 INFO - 'PAGER': '/bin/cat', 13:05:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:59 INFO - 'PWD': '/builds/slave/test', 13:05:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:05:59 INFO - 'SHELL': '/bin/bash', 13:05:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v7kKg5pyBR/Listeners', 13:05:59 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 13:05:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:05:59 INFO - 'USER': 'cltbld', 13:05:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:05:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:59 INFO - 'XPC_FLAGS': '0x0', 13:05:59 INFO - 'XPC_SERVICE_NAME': '0', 13:05:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:00 INFO - Downloading/unpacking psutil>=0.7.1 13:06: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:06: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:06: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:06: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:06: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:06: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:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:06:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:06:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:06:03 INFO - Installing collected packages: psutil 13:06:03 INFO - Running setup.py install for psutil 13:06:03 INFO - building 'psutil._psutil_osx' extension 13:06: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:06: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:06: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:06: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:06:04 INFO - building 'psutil._psutil_posix' extension 13:06: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:06:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:06:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:06:04 INFO - ^ 13:06:04 INFO - 1 warning generated. 13:06: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:06:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:06:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:06:04 INFO - Successfully installed psutil 13:06:04 INFO - Cleaning up... 13:06:04 INFO - Return code: 0 13:06:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:06: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:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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 0x10b49aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f878ac8d1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ed30>, '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 0x10b162db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b335b20>, '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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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:06: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:06: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:06:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ZYDghtrRk/Render', 13:06:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:06:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:06:04 INFO - 'HOME': '/Users/cltbld', 13:06:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:06:04 INFO - 'LOGNAME': 'cltbld', 13:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:04 INFO - 'MOZ_NO_REMOTE': '1', 13:06:04 INFO - 'NO_EM_RESTART': '1', 13:06:04 INFO - 'PAGER': '/bin/cat', 13:06:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:04 INFO - 'PWD': '/builds/slave/test', 13:06:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:06:04 INFO - 'SHELL': '/bin/bash', 13:06:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v7kKg5pyBR/Listeners', 13:06:04 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 13:06:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:06:04 INFO - 'USER': 'cltbld', 13:06:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:06:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:04 INFO - 'XPC_FLAGS': '0x0', 13:06:04 INFO - 'XPC_SERVICE_NAME': '0', 13:06:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:06: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:06:07 INFO - Installing collected packages: mozsystemmonitor 13:06:07 INFO - Running setup.py install for mozsystemmonitor 13:06:07 INFO - Successfully installed mozsystemmonitor 13:06:07 INFO - Cleaning up... 13:06:07 INFO - Return code: 0 13:06:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:06: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:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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 0x10b49aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f878ac8d1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ed30>, '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 0x10b162db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b335b20>, '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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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:06: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:06: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:06:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ZYDghtrRk/Render', 13:06:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:06:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:06:07 INFO - 'HOME': '/Users/cltbld', 13:06:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:06:07 INFO - 'LOGNAME': 'cltbld', 13:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:07 INFO - 'MOZ_NO_REMOTE': '1', 13:06:07 INFO - 'NO_EM_RESTART': '1', 13:06:07 INFO - 'PAGER': '/bin/cat', 13:06:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:07 INFO - 'PWD': '/builds/slave/test', 13:06:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:06:07 INFO - 'SHELL': '/bin/bash', 13:06:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v7kKg5pyBR/Listeners', 13:06:07 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 13:06:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:06:07 INFO - 'USER': 'cltbld', 13:06:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:06:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:07 INFO - 'XPC_FLAGS': '0x0', 13:06:07 INFO - 'XPC_SERVICE_NAME': '0', 13:06:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:07 INFO - Downloading/unpacking blobuploader==1.2.4 13:06: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:06: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:06: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:06: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:06: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:06: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:06:10 INFO - Downloading blobuploader-1.2.4.tar.gz 13:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:06:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:06: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:06: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:06: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:06: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:06: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:06: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:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:06:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:06: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:06: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:06: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:06: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:06: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:06: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:06:11 INFO - Downloading docopt-0.6.1.tar.gz 13:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:06:11 INFO - Installing collected packages: blobuploader, requests, docopt 13:06:11 INFO - Running setup.py install for blobuploader 13:06:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:06:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:06:11 INFO - Running setup.py install for requests 13:06:11 INFO - Running setup.py install for docopt 13:06:12 INFO - Successfully installed blobuploader requests docopt 13:06:12 INFO - Cleaning up... 13:06:12 INFO - Return code: 0 13:06:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06: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:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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 0x10b49aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f878ac8d1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ed30>, '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 0x10b162db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b335b20>, '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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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:06: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:06: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:06:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ZYDghtrRk/Render', 13:06:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:06:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:06:12 INFO - 'HOME': '/Users/cltbld', 13:06:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:06:12 INFO - 'LOGNAME': 'cltbld', 13:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:12 INFO - 'MOZ_NO_REMOTE': '1', 13:06:12 INFO - 'NO_EM_RESTART': '1', 13:06:12 INFO - 'PAGER': '/bin/cat', 13:06:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:12 INFO - 'PWD': '/builds/slave/test', 13:06:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:06:12 INFO - 'SHELL': '/bin/bash', 13:06:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v7kKg5pyBR/Listeners', 13:06:12 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 13:06:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:06:12 INFO - 'USER': 'cltbld', 13:06:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:06:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:12 INFO - 'XPC_FLAGS': '0x0', 13:06:12 INFO - 'XPC_SERVICE_NAME': '0', 13:06:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:06:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-ZsfZPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:06:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Fuo5v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:06:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-m0oURl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:06:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-RR_aOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:06:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-yMj6Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:06:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Z12qrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:06:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-IZVIMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:06:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-3b_0BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:06:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-qP_G4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:06:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-jpDDEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:06:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-dS4hZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:06:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-wVtC05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:06:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-ywmS1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:06:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-J3lKpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-xoLoJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:06:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-11ucQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:06:14 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-AbCC5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:06:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:06:14 INFO - Running setup.py install for manifestparser 13:06:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:06:14 INFO - Running setup.py install for mozcrash 13:06:14 INFO - Running setup.py install for mozdebug 13:06:14 INFO - Running setup.py install for mozdevice 13:06:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:06:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:06:14 INFO - Running setup.py install for mozfile 13:06:14 INFO - Running setup.py install for mozhttpd 13:06:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:06:15 INFO - Running setup.py install for mozinfo 13:06:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:06:15 INFO - Running setup.py install for mozInstall 13:06:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:06:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:06:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:06:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:06:15 INFO - Running setup.py install for mozleak 13:06:15 INFO - Running setup.py install for mozlog 13:06:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:06:15 INFO - Running setup.py install for moznetwork 13:06:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:06:15 INFO - Running setup.py install for mozprocess 13:06:15 INFO - Running setup.py install for mozprofile 13:06:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:06:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:06:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:06:16 INFO - Running setup.py install for mozrunner 13:06:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:06:16 INFO - Running setup.py install for mozscreenshot 13:06:16 INFO - Running setup.py install for moztest 13:06:16 INFO - Running setup.py install for mozversion 13:06:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:06:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:06:16 INFO - Cleaning up... 13:06:16 INFO - Return code: 0 13:06:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06: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:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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 0x10b49aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f878ac8d1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ed30>, '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 0x10b162db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b335b20>, '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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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:06: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:06: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:06:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ZYDghtrRk/Render', 13:06:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:06:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:06:16 INFO - 'HOME': '/Users/cltbld', 13:06:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:06:16 INFO - 'LOGNAME': 'cltbld', 13:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:16 INFO - 'MOZ_NO_REMOTE': '1', 13:06:16 INFO - 'NO_EM_RESTART': '1', 13:06:16 INFO - 'PAGER': '/bin/cat', 13:06:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:16 INFO - 'PWD': '/builds/slave/test', 13:06:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:06:16 INFO - 'SHELL': '/bin/bash', 13:06:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v7kKg5pyBR/Listeners', 13:06:16 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 13:06:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:06:16 INFO - 'USER': 'cltbld', 13:06:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:06:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:16 INFO - 'XPC_FLAGS': '0x0', 13:06:16 INFO - 'XPC_SERVICE_NAME': '0', 13:06:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:06:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-MGD44I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:06: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:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:06:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-UaQMMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:06: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:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:06:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-lGOW8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:06: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:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:06:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-GNKAzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:06: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:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:06:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-b7CYI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:06: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:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:06:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-QYFFWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:06: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:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:06:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-ZTn19w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:06: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:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:06:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-AZi58x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:06:17 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:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:06:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-JWVg88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:06:17 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:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:06:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-u_deH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:06: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:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:06:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-1Ks93w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:06: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:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:06:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-B4g71w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:06: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:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:06:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Oj0tcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:06: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:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:06:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Bkcvxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:06: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:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-cKEhGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:06: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:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:06:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-aobZsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:06: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:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:06:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-iur_5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:21 INFO - Downloading blessings-1.6.tar.gz 13:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:06:21 INFO - Installing collected packages: blessings 13:06:21 INFO - Running setup.py install for blessings 13:06:21 INFO - Successfully installed blessings 13:06:21 INFO - Cleaning up... 13:06:21 INFO - Return code: 0 13:06:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:06:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:06:21 INFO - Reading from file tmpfile_stdout 13:06:21 INFO - Current package versions: 13:06:21 INFO - blessings == 1.6 13:06:21 INFO - blobuploader == 1.2.4 13:06:21 INFO - docopt == 0.6.1 13:06:21 INFO - manifestparser == 1.1 13:06:21 INFO - mozInstall == 1.12 13:06:21 INFO - mozcrash == 0.16 13:06:21 INFO - mozdebug == 0.1 13:06:21 INFO - mozdevice == 0.48 13:06:21 INFO - mozfile == 1.2 13:06:21 INFO - mozhttpd == 0.7 13:06:21 INFO - mozinfo == 0.9 13:06:21 INFO - mozleak == 0.1 13:06:21 INFO - mozlog == 3.1 13:06:21 INFO - moznetwork == 0.27 13:06:21 INFO - mozprocess == 0.22 13:06:21 INFO - mozprofile == 0.28 13:06:21 INFO - mozrunner == 6.11 13:06:21 INFO - mozscreenshot == 0.1 13:06:21 INFO - mozsystemmonitor == 0.0 13:06:21 INFO - moztest == 0.7 13:06:21 INFO - mozversion == 1.4 13:06:21 INFO - psutil == 3.1.1 13:06:21 INFO - requests == 1.2.3 13:06:21 INFO - wsgiref == 0.1.2 13:06:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06: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:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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 0x10b49aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f878ac8d1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ed30>, '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 0x10b162db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b335b20>, '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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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:06: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:06: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:06:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ZYDghtrRk/Render', 13:06:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:06:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:06:21 INFO - 'HOME': '/Users/cltbld', 13:06:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:06:21 INFO - 'LOGNAME': 'cltbld', 13:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:21 INFO - 'MOZ_NO_REMOTE': '1', 13:06:21 INFO - 'NO_EM_RESTART': '1', 13:06:21 INFO - 'PAGER': '/bin/cat', 13:06:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:21 INFO - 'PWD': '/builds/slave/test', 13:06:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:06:21 INFO - 'SHELL': '/bin/bash', 13:06:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v7kKg5pyBR/Listeners', 13:06:21 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 13:06:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:06:21 INFO - 'USER': 'cltbld', 13:06:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:06:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:21 INFO - 'XPC_FLAGS': '0x0', 13:06:21 INFO - 'XPC_SERVICE_NAME': '0', 13:06:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06: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:06: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:06: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:06: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:06: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:06: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:06: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:06: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:06: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:06: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:06: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:06:22 INFO - Cleaning up... 13:06:22 INFO - Return code: 0 13:06:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:06: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:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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 0x10b49aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f878ac8d1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ed30>, '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 0x10b162db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b335b20>, '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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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:06: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:06: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:06:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ZYDghtrRk/Render', 13:06:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:06:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:06:22 INFO - 'HOME': '/Users/cltbld', 13:06:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:06:22 INFO - 'LOGNAME': 'cltbld', 13:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:22 INFO - 'MOZ_NO_REMOTE': '1', 13:06:22 INFO - 'NO_EM_RESTART': '1', 13:06:22 INFO - 'PAGER': '/bin/cat', 13:06:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:22 INFO - 'PWD': '/builds/slave/test', 13:06:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:06:22 INFO - 'SHELL': '/bin/bash', 13:06:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v7kKg5pyBR/Listeners', 13:06:22 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 13:06:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:06:22 INFO - 'USER': 'cltbld', 13:06:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:06:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:22 INFO - 'XPC_FLAGS': '0x0', 13:06:22 INFO - 'XPC_SERVICE_NAME': '0', 13:06:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:22 INFO - Downloading/unpacking jsonschema 13:06: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:06: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:06: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:06: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:06: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:06: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:06:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:06:24 INFO - Downloading/unpacking functools32 (from jsonschema) 13:06: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:06: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:06: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:06: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:06: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:06: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:06:25 INFO - Downloading functools32-3.2.3-2.tar.gz 13:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:06:25 INFO - warning: no files found matching '*.txt' 13:06:25 INFO - no previously-included directories found matching 'build' 13:06:25 INFO - no previously-included directories found matching 'dist' 13:06:25 INFO - no previously-included directories found matching '.git*' 13:06:25 INFO - Installing collected packages: jsonschema, functools32 13:06:25 INFO - Running setup.py install for functools32 13:06:25 INFO - warning: no files found matching '*.txt' 13:06:25 INFO - no previously-included directories found matching 'build' 13:06:25 INFO - no previously-included directories found matching 'dist' 13:06:25 INFO - no previously-included directories found matching '.git*' 13:06:25 INFO - Successfully installed jsonschema functools32 13:06:25 INFO - Cleaning up... 13:06:25 INFO - Return code: 0 13:06:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:06: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:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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 0x10b49aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4a24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f878ac8d1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ed30>, '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 0x10b162db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b335b20>, '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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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:06: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:06: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:06:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ZYDghtrRk/Render', 13:06:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:06:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:06:25 INFO - 'HOME': '/Users/cltbld', 13:06:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:06:25 INFO - 'LOGNAME': 'cltbld', 13:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:25 INFO - 'MOZ_NO_REMOTE': '1', 13:06:25 INFO - 'NO_EM_RESTART': '1', 13:06:25 INFO - 'PAGER': '/bin/cat', 13:06:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:25 INFO - 'PWD': '/builds/slave/test', 13:06:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:06:25 INFO - 'SHELL': '/bin/bash', 13:06:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v7kKg5pyBR/Listeners', 13:06:25 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 13:06:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:06:25 INFO - 'USER': 'cltbld', 13:06:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:06:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:25 INFO - 'XPC_FLAGS': '0x0', 13:06:25 INFO - 'XPC_SERVICE_NAME': '0', 13:06:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:25 INFO - Downloading/unpacking flake8 13:06:25 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:06:25 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:06:25 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:06:25 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:06:25 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:06:25 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:06:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:06:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:06: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:06: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:06: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:06: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:06: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:06: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:06:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:06:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:06: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:06: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:06: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:06: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:06: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:06: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:06:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:06: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:06: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:06: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:06: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:06: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:06: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:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:06:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:06:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:06:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:06:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:06:29 INFO - no previously-included directories found matching 'docs/_build' 13:06:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:06:29 INFO - Running setup.py install for pep8 13:06:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:06:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:06:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:06:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:06:29 INFO - no previously-included directories found matching 'docs/_build' 13:06:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:06:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:06:29 INFO - Cleaning up... 13:06:29 INFO - Return code: 0 13:06:29 INFO - Running post-action listener: _resource_record_post_action 13:06:29 INFO - Running post-action listener: _start_resource_monitoring 13:06:29 INFO - Starting resource monitoring. 13:06:29 INFO - ##### 13:06:29 INFO - ##### Running install step. 13:06:29 INFO - ##### 13:06:29 INFO - Running pre-action listener: _resource_record_pre_action 13:06:29 INFO - Running main action method: install 13:06:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:06:30 INFO - Reading from file tmpfile_stdout 13:06:30 INFO - Detecting whether we're running mozinstall >=1.0... 13:06:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:06:30 INFO - Reading from file tmpfile_stdout 13:06:30 INFO - Output received: 13:06:30 INFO - Usage: mozinstall [options] installer 13:06:30 INFO - Options: 13:06:30 INFO - -h, --help show this help message and exit 13:06:30 INFO - -d DEST, --destination=DEST 13:06:30 INFO - Directory to install application into. [default: 13:06:30 INFO - "/builds/slave/test"] 13:06:30 INFO - --app=APP Application being installed. [default: firefox] 13:06:30 INFO - mkdir: /builds/slave/test/build/application 13:06: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:06: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:07:04 INFO - Reading from file tmpfile_stdout 13:07:04 INFO - Output received: 13:07:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:07:04 INFO - Running post-action listener: _resource_record_post_action 13:07:04 INFO - ##### 13:07:04 INFO - ##### Running run-tests step. 13:07:04 INFO - ##### 13:07:04 INFO - Running pre-action listener: _resource_record_pre_action 13:07:04 INFO - Running main action method: run_tests 13:07:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:07:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:07:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:07:04 INFO - 2016-03-02 13:07:04.021 screenresolution[1644:8073] starting screenresolution argv=screenresolution get 13:07:04 INFO - 2016-03-02 13:07:04.024 screenresolution[1644:8073] Display 0: 1600x1200x32@60 13:07:04 INFO - 2016-03-02 13:07:04.030 screenresolution[1645:8075] starting screenresolution argv=screenresolution list 13:07:04 INFO - Available Modes on Display 0 13:07:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:07:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:07:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:07:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:07:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:07:04 INFO - Intel Iris: 13:07:04 INFO - Chipset Model: Intel Iris 13:07:04 INFO - Type: GPU 13:07:04 INFO - Bus: Built-In 13:07:04 INFO - VRAM (Dynamic, Max): 1536 MB 13:07:04 INFO - Vendor: Intel (0x8086) 13:07:04 INFO - Device ID: 0x0a2e 13:07:04 INFO - Revision ID: 0x0009 13:07:04 INFO - Displays: 13:07:04 INFO - Display: 13:07:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:07:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:07:04 INFO - Display Serial Number: 1600x1200 60 13:07:04 INFO - Main Display: Yes 13:07:04 INFO - Mirror: Off 13:07:04 INFO - Online: Yes 13:07:04 INFO - Rotation: Supported 13:07:04 INFO - Return code: 0 13:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:07:04 INFO - Python 2.7.3 13:07:04 INFO - Return code: 0 13:07:04 INFO - grabbing minidump binary from tooltool 13:07: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:07:04 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 0x10b33ed30>, '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 0x10b162db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b335b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:07:04 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:07:04 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:07:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:07:04 INFO - Return code: 0 13:07:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:07:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:07:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:07:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:07:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:07:05 INFO - Return code: 0 13:07:05 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/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0161', '--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:07:05 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/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0161 --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:07:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ZYDghtrRk/Render', 13:07:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:07:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:07:05 INFO - 'HOME': '/Users/cltbld', 13:07:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:07:05 INFO - 'LOGNAME': 'cltbld', 13:07:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:07:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:05 INFO - 'MOZ_NO_REMOTE': '1', 13:07:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:07:05 INFO - 'NO_EM_RESTART': '1', 13:07:05 INFO - 'PAGER': '/bin/cat', 13:07:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:05 INFO - 'PWD': '/builds/slave/test', 13:07:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:07:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:07:05 INFO - 'SHELL': '/bin/bash', 13:07:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v7kKg5pyBR/Listeners', 13:07:05 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 13:07:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:07:05 INFO - 'USER': 'cltbld', 13:07:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:07:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:05 INFO - 'XPC_FLAGS': '0x0', 13:07:05 INFO - 'XPC_SERVICE_NAME': '0', 13:07:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:07:05 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/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0161', '--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:07:06 INFO - mozversion application_buildid: 20160302120522 13:07:06 INFO - mozversion application_changeset: a10be60e15925625be398dda0c8db1c168d7fd8d 13:07:06 INFO - mozversion application_display_name: Nightly 13:07:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:07:06 INFO - mozversion application_name: Firefox 13:07:06 INFO - mozversion application_remotingname: firefox 13:07:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:07:06 INFO - mozversion application_vendor: Mozilla 13:07:06 INFO - mozversion application_version: 47.0a1 13:07:06 INFO - mozversion platform_buildid: 20160302120522 13:07:06 INFO - mozversion platform_changeset: a10be60e15925625be398dda0c8db1c168d7fd8d 13:07:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:07:06 INFO - mozversion platform_version: 47.0a1 13:07:06 INFO - using testdate: 1456952826 13:07:06 INFO - actual date: 1456952826 13:07:06 INFO - starting webserver on 'localhost:49272' 13:07:06 INFO - SUITE-START | Running 2 tests 13:07:06 INFO - TEST-START | dromaeo_css 13:07:06 INFO - operating with platform_type : mac_ 13:07:06 INFO - Initialising browser for dromaeo_css test... 13:07:06 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpCDoAff/profile http://localhost:49272/getInfo.html) 13:07:08 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 13:07:08 INFO - PROCESS | 1663 | colorDepth:24 13:07:08 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 13:07:08 INFO - PROCESS | 1663 | __metrics 13:07:09 INFO - PROCESS | 1663 | 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:07:09 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:07:09 INFO - TEST-INFO | 1663: exit 0 13:07:09 INFO - Browser initialized. 13:07:09 INFO - Running cycle 1/1 for dromaeo_css test... 13:07:09 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpCDoAff/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:21 INFO - PROCESS | 1667 | RSS: Main: 242704384 13:07:21 INFO - PROCESS | 1667 | 13:08:12 INFO - PROCESS | 1667 | 1456952892530 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:10:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 13:10:24 INFO - PROCESS | 1667 | RSS: Main: 347279360 13:10:24 INFO - PROCESS | 1667 | 13:13:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 13:13:27 INFO - PROCESS | 1667 | RSS: Main: 373743616 13:13:27 INFO - PROCESS | 1667 | 13:16:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 13:16:29 INFO - PROCESS | 1667 | RSS: Main: 374059008 13:16:29 INFO - PROCESS | 1667 | 13:19:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 13:19:32 INFO - PROCESS | 1667 | RSS: Main: 330956800 13:19:32 INFO - PROCESS | 1667 | 13:22:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 13:22:36 INFO - PROCESS | 1667 | RSS: Main: 330653696 13:22:36 INFO - PROCESS | 1667 | 13:25:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 13:25:39 INFO - PROCESS | 1667 | RSS: Main: 438173696 13:25:39 INFO - PROCESS | 1667 | 13:25:39 INFO - PROCESS | 1667 | __start_tp_report 13:25:39 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 13:25:39 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 13:25:39 INFO - PROCESS | 1667 | |i|pagename|runs| 13:25:39 INFO - PROCESS | 1667 | |0;dojo.html;3411.471221960597;3417.948730769039;3459.8443070061844;3460.446328587426;3492.4586689063203;5563.332400111982;5575.526080283175;5585.245991791107;5619.325680918296;5646.520045796102;5587.3015873015875;5640.182173584828;5693.544516438686;5776.855578610537;5802.709864506779;5058.2412638104215;5093.719845408501;5118.820841270556;5125.282460455539;5250.238715386286;5198.45416231296;5212.113940630083;5272.578193744491;5284.8150314739;5330.760115794779;5075.771590278447;5080.136376815932;5168.9224661630105;5177.637565370425;5178.197379406198;5165.380154381461;5166.354205724285;5180.792768289264;5187.584993200535;5189.532942035235;5098.694078355274;5107.642465027449;5155.149400348938;5173.224016397533;5177.404598471187;5454.34547854256;5553.916691249635;5601.831945041656;5603.691796951166;5606.971965140148;6099.128199784669;6117.449429551317;6126.969365153146;6131.632102073845;6136.17161683176;6083.1186467757125;6130.662813545253;6162.044883043135;6171.166892469504;6187.412195841388;5705.400932902068;5718.027935251017;5761.53907687384;5774.0761478163295;5790.68151251681;6164.7842325518395;6166.9383306167265;6174.44430001302;6175.475084617858;6178.351273116348;5975.52195824333;6033.577649564576;6086.847828804227;6100.267967843798;6128.295246046672;6129.601575897553;6202.81391558254;6203.31763506014;6240.781572644935;6256.843578910563;6117.174181485531;6141.57009009374;6167.753289868445;6175.166352542349;6198.690065496798;6002.849928751816;6122.8251069701855;6128.816135515942;6152.661603611755;6179.938200617937;4829.9034019319415;4831.4202295724735;4843.321934929113;4860.78126484302;4900.852974410774;4344.23975804233;4353.368761529624;4367.148406060787;4367.47590289161;4388.5611438856495;5464.508194262536;5545.251391062236;5566;5570.248016517799;5643.971780141155;6193.876122477525;6198.101275315144;6203.751849925952;6211.875762484725;6222.253329600477;5579.38626751057;5587.916181257285;5601.383847776741;5605.495505404533;5617.354004289477;5196.402413722471;5287.603429742785;5311.123664595299;5351.51836334724;5372.677639341574;6253.937460625336;6260.968695156495;6262.029385445263;6263.217097862767;6271.435570798559;5279.498447647467;6122.561198118349;6205.627662340274;6206.937930620636;6211.3167551570195;5275.366955965309;6148.616561273678;6195.969020155051;6248.812535623939;6283.717232724447;6063.605865618721;6088.056351265561;6107.755689772359;6119.663418511846;6128.571000029955;6039.4262545058145;6189.164462797645;6208.441240288395;6219.782307619212;6226.875462490634;5967.254093238345;6009.54928380382;6029.487493563096;6055.818325450244;6088.056351265561;5725.6850873202375;5914.083317085859;5930;5931.258592675916;5937.495312898452;5694.857628559319;5789.218455508452;5810.94189058104;5821.417858214314;5855.531557475307;6052.788152414644;6078.088286757022;6081.422264884829;6101.908471372844;6114.296855861633;5805.3614102447855;5852.707364631837;5858.502027327554;5858.648481091148;5870.471657550841 13:25:39 INFO - PROCESS | 1667 | |1;ext.html;455.8541266794627;567.6008638705592;580.3181262017129;626.3485974586429;627.1815281058219;30709.925152619635;30713.692863071334;30750;38016.619833801655;38412;40892;41328;41406.378904316385;41446.17107657845;41742.58257417425;9551.188149007343;9785.804283914318;9789.510524473784;9790.461524616143;9816.460094694788;9442.291828112919;9595.328327017112;9601.663941762039;9604.3757155785;9612.279079069098;9561.904380956172;9660.468674222915;9661.227101831837;9782.755431114208;9806.362586431895;9672;9747.90252097477;9753.46355950419;9756;9776.413415195075;9617.71146865595;9768;9769.755756106084;9786.461744604045;9800;39683.64270823431;39946.800265998485;39959.20081598381;40007.19985600301;40148.59479918189;3068.9693103068907;3090.2428904918215;3129.4679904416303;3132.7493800495904;3602.9279414411567;28279.151625451064;28995;29075.418491630047;29750.10749677513;29916.80332786686;2720.986395068032;2758.3379988802744;2759.103291430293;2791.4556661451024;2843.1044221070297;472849;474403;475473;477165;479796;59177.11234331488;59864.40135598675;60223.698881506185;60234.39765602376;60493.69753151206;64601.67699161474;64617;64747.67626161839;64757;64856.67571662112;16204.189790510427;16354.100524471269;16408.343666253215;16416;16448.75326870098;10514;12496.81254781179;12618.684532886751;12623.179493332904;12627.305498197504;18157.140126170703;19234.903825480782;19273.4217973461;19522.70715939262;19551.80448195528;8000.279974802179;8092.433529652868;8213.260806527322;8215.219554142346;8247.422680412314;729.2580097003239;851.2721623012359;913.4015472922385;995.5022488755623;1114.4650567727374;25905.870470647526;26966.460670786473;27576.586351204747;27749.722502774715;27786;1038.5638032026568;1045.9215558833118;1049.7008352619466;1052.1319911073394;1141.155544896787;13944.58166255014;14092.295385230698;14184.574462766133;14246.572602821932;14310.642233944234;502477;513310;517790;518891;519765;56671;56825.57936051549;56830;56954;57092;1291.9935400322938;1399.9930000350137;1418.6169734171922;1420.5454254638416;1443.1052747296744;26745.197644070708;27816.86091569529;27896;28556.57165142566;28616.284592885346;43804.90487737832;43997.94023687317;44270.335944961495;44333.11333773242;44343.44797932057;314027;315497;317048;317845;318863;28104;31832;32701.836490817393;32717.509237361934;32719.672803271664;40105.79947100246;40593.1881362377;40692.593074070064;40792.38811417772;40830;33824.98525044253;34471.655283446846;34836.65163348334;35122.64877351194;35350.46974295336;29129.563056553743;34945.47581786224;35364;35681.64318356783;35929.1017724559;34631.65368346284;34901.9529414118;35084.64915350814;35667;35931.28137437184;30097.79608815623;30949.845250773604;31063.37873242477;31093.689063109985;31113.222169445944;23587.93854276596;23607.64588531208;23816.16643417472;24027.759722402552;24044.51910961736 13:25:39 INFO - PROCESS | 1667 | |2;jquery.html;300.54617527533424;355.17599169925785;358.20121129880374;360.9440536716808;368.29655358265717;19379.031048447574;19464.63747537673;21151.875384300067;21172.364829055114;21262.362129136112;15233.77149342758;16481.67036659266;20233.59532809343;20263.898680506576;20289;5805.448482394177;6081.270247570298;6121.540884433663;6155.353687862777;6164.476019538344;3698.7780733156096;4426.645868330542;4474.709143905636;4481.3726078349055;5968.253968253968;6553.049807777869;6556.901646475307;6558.93441065588;6566.080748695186;6582.967085164568;6209.285932117819;6503.187101612299;6510.056041873901;6511.38141876521;6520.902186467207;5621.241132447149;5635.408282130399;5650.63270887391;5652.236948012007;5654.491095801356;23577;24949.875250623812;25121.874390628112;25727.871360643265;25764.355891102685;1987.28457755208;2196.5826492966285;2294;2413.915512957038;2637.222019504251;9934.205263578897;9981.251406144569;10053.698389048268;10130.949345253226;10260.076593106656;1698.8301169883036;1731.6796392667397;1768.6462707458559;1801.9984718735484;1888.2447021191497;104653;106002.99999999923;108817.91182088156;109375;111297.44351278192;11267.38029408374;11311.660650180507;11361.14791390649;11383.203175777782;11470.88529114715;13607.11553749023;13685.79471307931;13704.725905481835;13724.93137534306;13730.51943181984;8201.753947381589;8388;8398.244158025807;8480.406371553932;8532.829343413097;8414.11651776567;8424.15758424165;8424.747257582283;8520.74437766868;8532.786680333042;4375.496817865923;4478.753668548196;4484.260097084009;4525.094981003813;4525.705829121097;1645.7860478138005;1768.2750072470226;1772.9113544322731;1878.7839398469077;1889.1970912362465;884.3588398411229;885.3050355471053;926.5413620258015;1016.0230524562953;1017.6133069433716;18871.18266797756;20038.398848034583;20076.59846803056;20148;20162.495937601678;860.8665656823202;906.8911730592239;928.7770934975692;938.6252780465434;951.509972364233;8366.623501942306;10223.539940702687;10345.172386209086;10359.378437293786;10590.629327973484;498496;502677;504720.4763976157;558373;624909;99303.50348248357;111928.88071119347;112537.43731281291;125979;131345;1005.7938122684832;1039.2361614213546;1053.841923711434;1054.4569546683465;1058.2327812335996;15418.383264669288;17732;18638.81361186425;18695.439136825917;18787.624247515247;36873.63126368702;48170.55488335356;48963;49143.262851057974;49486.76283092952;70347.64826175837;71959;72167.63916180386;72517;72531.27468725457;7809;7944.8877157196885;8011.595072094453;8039.5176289422825;8184.672613095409;9379.577918993526;12716.872831271568;13054.08621396493;13114.540991065267;13147.882429993557;5653.632513886584;10942.17933654995;11359.04256646486;11402.144839137263;11434.199606027498;9462.858057129286;11395.772084558428;11490;11681.824772628588;11723.941380293043;11333.773324533298;11494.885051149382;11536.826947595624;11558.364289964133;11825.231359961575;7968.641411136628;8071.838563228585;8135.959320203598;8222.876656850272;8374.2881855043;9250.95374523123;10463.372197668165;11226;11390.145739069769;11568.595099171489 13:25:39 INFO - PROCESS | 1667 | |3;mootools.html;1349.156777014366;1523.3754160794074;1551.2786554252275;1779.2616064333301;1930.382277671145;7805.219478052199;8327.583620818958;8453.535055571941;8476.067632560429;8531.402801803884;8172.1827817218245;8440.987081550207;8442.113578074306;8446.746597602067;8450.873236901436;2120.215520257507;2332.778386053331;2375.619900815874;2409.409694624819;2417.407735104893;2397.436602398435;2408.0488207158164;2408.5544174327806;2410.0600765701392;2410.120306088274;2343.4727186383097;2360.7875291223786;2366.928992130239;2408.434018005767;2409.638554216864;2363.397333679901;2400.567897778399;2408.9759102408925;2417.9637305440433;2435.281591930367;2329.1615018593293;2338.75443078476;2363.1256435118944;2364.219807463533;2367.4673198530363;8485.703000394957;8586.570671466401;8586.914130858673;8597.18326758957;8602.655893764242;5262.6843289177705;5420.593455490854;5423;5429.755660995225;5431.180554514242;3509.175343794206;3591.964080359189;3659.1035196376793;3663;3672.8714494992814;1038.5015192707542;1053.8893416191265;1058.4654749351528;1065.3767545985609;1068.8289873620183;11275.887241127566;11424.543018279259;11430.028447581966;11440.19918605698;11465.197436179471;4704.29435584665;4784.64115191362;4788.928166077511;4826.493218212107;4864.881077352229;9898.356606820533;9902.851457228147;9911.207103431709;9919.752006199902;9925.15636170919;5344.43883392246;5360.3031605891765;5368.865778355573;5369.946300537023;5373;4364.912701745948;4502.482214545304;4692.741899195509;4805.063012712488;4873.26900964851;3804.8097595120134;3855.306044911943;3872.7482713623526;3886.378179491268;3938.271419787291;1243.7885559454915;1269.3399432295155;1271.9364031798373;1280.3150314581653;1294.5145570411096;1285.4279845468864;1289.3939848271298;1291.309149604957;1323.0540163782941;1323.8543760186371;7861.882071768814;7904.762857114296;7953.840923181504;7957.721479748181;7964.084130324971;489.9142650036229;493.580456611877;497.8805086779219;500.74712270303263;505.47683147941706;5932.495737862244;5989.460948514655;6008.909866352008;6010.278766548042;6021.939780602225;9774.12032917041;10509;10524.105451036594;10564.735881602868;10569.312994655324;9948.602055917827;10294.742631434125;10364.948175259075;10452.68641940743;10463.633772817915;7581.128170260491;8111.472754270953;8116.553589552631;8122.431429799857;8208.712695055645;7502.474826762074;7535.8492830141995;7589.241075892367;7591.696332146652;7620.047494063242;9099.317551183556;9296.860547091665;9494.28792840526;9497.287703422133;9502.714918552454;9462.053794620759;9691.67399824023;9699.6120155193;9770.120689138012;9825.803483930424;6030.185924900083;6542.771003014872;6752.628605426748;7289.489735718449;7358.374538164316;7858.685652573833;7863.646135924012;7919.326857217201;7929.960350198212;7952.84094318122;6894.172699276119;6949.722011119498;6982.057422248135;7100.147982242164;7110.182329032227;6251.78118765841;6516.837079073061;6846.144231971004;6941.409980151541;6964.233934267125;7314.780556583311;7321.048263725682;7365.889511657437;7447.069116360455;7497.587632680255;6752.729890804313;6755.4257888080065;6807.591544507345;6815.352541508549;6820.35206655367;6647;6837.555558888656;6899.413549848118;6902.413294869792;6906.8618627628175 13:25:39 INFO - PROCESS | 1667 | |4;prototype.html;255.2864743043194;309.4445470380667;312.49220017471595;313.64244760972485;317.7013607209222;5138.460461651529;6466.030095485674;6525.347465253472;6527.608343499393;6593.703283352249;6451.580647257925;6459.483241340693;6484.092227088199;6495.935040649604;6507.6095434273975;4607.262837945921;4652.023075154221;4665.393498845146;4675.322078298645;4678.251479763238;4658.930116048262;4668.393108895839;4766.404199475066;4782.952170478303;4800.591949684281;4680.274557443602;4702.90594188116;4721.622270218374;4721.669483136165;4739.123262196505;4493.168763778712;4711;4727.7163370197895;4749.691270067435;4768.427788665348;3544.6428125296648;3864.265789499986;3946.269940061069;4050.3924411338535;4053.1285773558825;6190.164327815733;6190.350013248634;6213.844653883644;6234.781782637631;6238.1266622672865;5527.640703354309;5530.640508366943;5537.252470916415;5543.279373681396;5558.470895742427;5555.638883472561;6895.34494223048;6911.2397636260475;6914.582510585318;6915.377616014533;4239.47006624172;4504.279315309567;4515.525869783658;4517.921755992247;4524.502304746476;7111.928880711178;7269.745558905466;7309.5248808827255;7326.2673732626845;7332.78001659951;3570.2680950405106;4461.486929003141;4464.977675111603;4474.6420286377015;4481.193385190697;4557.134144512532;4561.521040290788;4564.018735971782;4566.885827854264;4581.931271030937;5434.2935418395355;5435.592330575223;5439.972800135974;5448.42791506894;5457.126859702428;6650.135482387259;6969.954506824017;6974.197967233732;6975.720971161097;6990.545614535039;1552.1230504764771;1556.5252597957506;1571.6070982254437;1573.1583602772462;1579.6445799694977;995.6266400099962;1002.7042022603349;1013.3869009249445;1020.7039958412125;1021.5403068619003;6165.599236049642;6251.374862513712;6361.459275961595;6395.42441180296;6418.26189988148;7069.92930070703;7140.642967851587;7144.142702875688;7157.391621712213;7218.67515961783;6463.6768161591735;6473.385028422293;6473.805785826433;6476.643784591798;6479.5788273763;3771.73597848148;3818.7899665518107;3820.121372084436;3820.9235815284096;3825.2349530093534;7301.502276545536;7462.291082347168;7558.395328373717;7577.469577129548;7618.352440042659;5978.790742323998;7461.440391970624;7462.440316976248;7484.962575187089;7487.288707572772;7532.887006694904;7534.962325188559;7544.170141284454;7545;7547.962260188664;7169.426445884213;7195.8920616191845;7205.747798827016;7211.567305961659;7223.494355395072;6814.829629259309;7061.940708893707;7096.822579435349;7165.713371465083;7174.748883789042;6989.161300643956;7481;7595.430342724208;7607.429442791702;7612.885806713015;4628.583427491542;4699.718016918996;4708;4708.529147085401;4722.574968252874;5483.670979741229;7132.750353737594;7132.928670713226;7148.17795953472;7161.104861892263;6617.867642647217;6807.965960170168;6872.759453419107;6901.585904845725;6933.826654333682;6831.316868313129;6853.0405743195;6865.759698410531;6884.277150899084;6889.414399775875;6701.530892837454;6717.596944183365;6727.8990815138795;6733.69698363565;6736.056952026818;6873.656317184221;6891.552049116792;6897.310268973062;6920.204176519765;6931.376176144171;5890.7349169288345;6295.5907865988565;6533.118029066205;6681.832954176184;6762.323767623198 13:25:39 INFO - PROCESS | 1667 | |5;yui.html;607.7356349987756;690.8618276344725;704.982375440614;734.6106563521332;776.5651235308228;14678.972471926969;15098.245087745623;15102;15108.093514389131;16800.83199168008;15593.986390884584;15679.137647429416;15691.21543922805;15707.371705131782;15707.528774136767;693.9375456208941;694.6040756768643;704.3027402871172;860.604122103833;861.7974775927652;705.6224919667978;836.2306677856386;854.5171977832536;856.7986523167051;859.5186695450536;896.8206358728248;897.6095398501673;900.3697411811726;903.0608167505786;903.5391950105461;724.6413025552386;893.3746377535718;893.3835653399134;893.4683863101444;894.3203165594131;542.6499907559602;542.734060310449;654.4829584628138;666.1839246922481;668.6957434367351;15101.3204405802;15139.54581362561;15172.924135379362;15176.317065732068;15185.924070379688;12173.756524869541;12175.695607609792;12275.386230688518;12320.383980801014;12457.377131143498;9897.15874150698;9950.900490995142;10060.748481288027;10145.949270253675;10230.335028223142;3043.360894212218;3442.9200103546555;3478.773879697837;3490.7730997485082;3501.3872572299747;85018;85123.5743821277;85941.57029214877;87042.12957870467;87562.68655970166;9203.309751768644;9219.677311294072;9273;9503.952480237554;9515.857262141073;21019.579608407745;21025;21052.684209736864;21056.684149737765;21071.26250581222;7337.449691273176;7377.188509263977;7532.058492688414;7611.20082391352;7670.232976702285;4064.6138616831354;4081.3061779497557;4082.6121518455698;4167.812448439828;4230.49234091911;3569.196930690626;3635.527381440396;3639.1448009717697;3639.6724294813594;3641.726870484671;620.221621864557;637.5218586060455;643.2698886763557;643.7489379142045;645.283735054099;520.8984248071665;568.7753337431691;590.7666471743723;590.8360529756374;607.0257237134424;7480.364169045583;8080.39397045224;8152.51084934894;8293.585320733939;8347.996480844553;569.481771587853;571.5399103721461;585.1106318396099;594.4590422715395;616.4328817487922;3765.3034188674633;3765.5293088363956;3782.6217378261954;3947.486826712509;3990.6408423242046;96663;98064.01935980549;98443;99493.50253248688;99976;71869.92195117078;73594;83027.16972830195;83115;84345;71276.86169414927;71599;71889;73018;73837.99999999892;7674.309312161932;7731.613419328898;7741.497142400411;7793.2596403341595;7803.648835802289;47886.76056619694;49985.75007124941;51682;52135;52207;67930.66034669992;72022.63988680023;72583.54832903207;72596.63701681458;73131.26868731457;9842.852357214504;9863.950680246553;10947.15374002749;10952.397618131079;11094.243019586755;11538.94230528842;11887.989520890475;12084.39578021113;12399.876001240233;12559.43482543306;11057.336559806437;11410.315381077162;11487;11551.133664974992;11655;9192.257169058525;11364.829527557258;11368.602098926498;11414.258073225546;11656.18406711522;10903.727406814893;11163.553457861595;11198.048165905664;11370.033547148585;12266.693332666755;9333.906660933575;9484.241260699266;9675.612975480903;9795.06946840049;9986.35088719231;7685.807854803675;8789.296856251356;9106.817863642822;9115.515845621327;9808.411495310018 13:25:39 INFO - PROCESS | 1667 | __end_tp_report 13:25:39 INFO - PROCESS | 1667 | __start_cc_report 13:25:39 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,969 13:25:39 INFO - PROCESS | 1667 | __end_cc_report 13:25:39 INFO - PROCESS | 1667 | __startTimestamp1456953939187__endTimestamp 13:25:39 INFO - PROCESS | 1667 | 13:25:39 INFO - PROCESS | 1667 | ------- Summary: start ------- 13:25:39 INFO - PROCESS | 1667 | Number of tests: 6 13:25:39 INFO - PROCESS | 1667 | 13:25:39 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5666.76 Median:5821.42 stddev:614.24 (10.6%) stddev-sans-first:590.09 13:25:39 INFO - PROCESS | 1667 | Values: 3411.5 3417.9 3459.8 3460.4 3492.5 5563.3 5575.5 5585.2 5619.3 5646.5 5587.3 5640.2 5693.5 5776.9 5802.7 5058.2 5093.7 5118.8 5125.3 5250.2 5198.5 5212.1 5272.6 5284.8 5330.8 5075.8 5080.1 5168.9 5177.6 5178.2 5165.4 5166.4 5180.8 5187.6 5189.5 5098.7 5107.6 5155.1 5173.2 5177.4 5454.3 5553.9 5601.8 5603.7 5607.0 6099.1 6117.4 6127.0 6131.6 6136.2 6083.1 6130.7 6162.0 6171.2 6187.4 5705.4 5718.0 5761.5 5774.1 5790.7 6164.8 6166.9 6174.4 6175.5 6178.4 5975.5 6033.6 6086.8 6100.3 6128.3 6129.6 6202.8 6203.3 6240.8 6256.8 6117.2 6141.6 6167.8 6175.2 6198.7 6002.8 6122.8 6128.8 6152.7 6179.9 4829.9 4831.4 4843.3 4860.8 4900.9 4344.2 4353.4 4367.1 4367.5 4388.6 5464.5 5545.3 5566.0 5570.2 5644.0 6193.9 6198.1 6203.8 6211.9 6222.3 5579.4 5587.9 5601.4 5605.5 5617.4 5196.4 5287.6 5311.1 5351.5 5372.7 6253.9 6261.0 6262.0 6263.2 6271.4 5279.5 6122.6 6205.6 6206.9 6211.3 5275.4 6148.6 6196.0 6248.8 6283.7 6063.6 6088.1 6107.8 6119.7 6128.6 6039.4 6189.2 6208.4 6219.8 6226.9 5967.3 6009.5 6029.5 6055.8 6088.1 5725.7 5914.1 5930.0 5931.3 5937.5 5694.9 5789.2 5810.9 5821.4 5855.5 6052.8 6078.1 6081.4 6101.9 6114.3 5805.4 5852.7 5858.5 5858.6 5870.5 13:25:39 INFO - PROCESS | 1667 | 13:25:39 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:58101.23 Median:35805.37 stddev:118074.41 (329.8%) stddev-sans-first:118326.31 13:25:39 INFO - PROCESS | 1667 | Values: 455.9 567.6 580.3 626.3 627.2 30709.9 30713.7 30750.0 38016.6 38412.0 40892.0 41328.0 41406.4 41446.2 41742.6 9551.2 9785.8 9789.5 9790.5 9816.5 9442.3 9595.3 9601.7 9604.4 9612.3 9561.9 9660.5 9661.2 9782.8 9806.4 9672.0 9747.9 9753.5 9756.0 9776.4 9617.7 9768.0 9769.8 9786.5 9800.0 39683.6 39946.8 39959.2 40007.2 40148.6 3069.0 3090.2 3129.5 3132.7 3602.9 28279.2 28995.0 29075.4 29750.1 29916.8 2721.0 2758.3 2759.1 2791.5 2843.1 472849.0 474403.0 475473.0 477165.0 479796.0 59177.1 59864.4 60223.7 60234.4 60493.7 64601.7 64617.0 64747.7 64757.0 64856.7 16204.2 16354.1 16408.3 16416.0 16448.8 10514.0 12496.8 12618.7 12623.2 12627.3 18157.1 19234.9 19273.4 19522.7 19551.8 8000.3 8092.4 8213.3 8215.2 8247.4 729.3 851.3 913.4 995.5 1114.5 25905.9 26966.5 27576.6 27749.7 27786.0 1038.6 1045.9 1049.7 1052.1 1141.2 13944.6 14092.3 14184.6 14246.6 14310.6 502477.0 513310.0 517790.0 518891.0 519765.0 56671.0 56825.6 56830.0 56954.0 57092.0 1292.0 1400.0 1418.6 1420.5 1443.1 26745.2 27816.9 27896.0 28556.6 28616.3 43804.9 43997.9 44270.3 44333.1 44343.4 314027.0 315497.0 317048.0 317845.0 318863.0 28104.0 31832.0 32701.8 32717.5 32719.7 40105.8 40593.2 40692.6 40792.4 40830.0 33825.0 34471.7 34836.7 35122.6 35350.5 29129.6 34945.5 35364.0 35681.6 35929.1 34631.7 34902.0 35084.6 35667.0 35931.3 30097.8 30949.8 31063.4 31093.7 31113.2 23587.9 23607.6 23816.2 24027.8 24044.5 13:25:39 INFO - PROCESS | 1667 | 13:25:39 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:32200.54 Median:25424.87 stddev:90116.84 (354.4%) stddev-sans-first:90337.81 13:25:39 INFO - PROCESS | 1667 | Values: 300.5 355.2 358.2 360.9 368.3 19379.0 19464.6 21151.9 21172.4 21262.4 15233.8 16481.7 20233.6 20263.9 20289.0 5805.4 6081.3 6121.5 6155.4 6164.5 3698.8 4426.6 4474.7 4481.4 5968.3 6553.0 6556.9 6558.9 6566.1 6583.0 6209.3 6503.2 6510.1 6511.4 6520.9 5621.2 5635.4 5650.6 5652.2 5654.5 23577.0 24949.9 25121.9 25727.9 25764.4 1987.3 2196.6 2294.0 2413.9 2637.2 9934.2 9981.3 10053.7 10130.9 10260.1 1698.8 1731.7 1768.6 1802.0 1888.2 104653.0 106003.0 108817.9 109375.0 111297.4 11267.4 11311.7 11361.1 11383.2 11470.9 13607.1 13685.8 13704.7 13724.9 13730.5 8201.8 8388.0 8398.2 8480.4 8532.8 8414.1 8424.2 8424.7 8520.7 8532.8 4375.5 4478.8 4484.3 4525.1 4525.7 1645.8 1768.3 1772.9 1878.8 1889.2 884.4 885.3 926.5 1016.0 1017.6 18871.2 20038.4 20076.6 20148.0 20162.5 860.9 906.9 928.8 938.6 951.5 8366.6 10223.5 10345.2 10359.4 10590.6 498496.0 502677.0 504720.5 558373.0 624909.0 99303.5 111928.9 112537.4 125979.0 131345.0 1005.8 1039.2 1053.8 1054.5 1058.2 15418.4 17732.0 18638.8 18695.4 18787.6 36873.6 48170.6 48963.0 49143.3 49486.8 70347.6 71959.0 72167.6 72517.0 72531.3 7809.0 7944.9 8011.6 8039.5 8184.7 9379.6 12716.9 13054.1 13114.5 13147.9 5653.6 10942.2 11359.0 11402.1 11434.2 9462.9 11395.8 11490.0 11681.8 11723.9 11333.8 11494.9 11536.8 11558.4 11825.2 7968.6 8071.8 8136.0 8222.9 8374.3 9251.0 10463.4 11226.0 11390.1 11568.6 13:25:39 INFO - PROCESS | 1667 | 13:25:39 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5850.71 Median:5426.38 stddev:3093.37 (57.0%) stddev-sans-first:3083.54 13:25:39 INFO - PROCESS | 1667 | Values: 1349.2 1523.4 1551.3 1779.3 1930.4 7805.2 8327.6 8453.5 8476.1 8531.4 8172.2 8441.0 8442.1 8446.7 8450.9 2120.2 2332.8 2375.6 2409.4 2417.4 2397.4 2408.0 2408.6 2410.1 2410.1 2343.5 2360.8 2366.9 2408.4 2409.6 2363.4 2400.6 2409.0 2418.0 2435.3 2329.2 2338.8 2363.1 2364.2 2367.5 8485.7 8586.6 8586.9 8597.2 8602.7 5262.7 5420.6 5423.0 5429.8 5431.2 3509.2 3592.0 3659.1 3663.0 3672.9 1038.5 1053.9 1058.5 1065.4 1068.8 11275.9 11424.5 11430.0 11440.2 11465.2 4704.3 4784.6 4788.9 4826.5 4864.9 9898.4 9902.9 9911.2 9919.8 9925.2 5344.4 5360.3 5368.9 5369.9 5373.0 4364.9 4502.5 4692.7 4805.1 4873.3 3804.8 3855.3 3872.7 3886.4 3938.3 1243.8 1269.3 1271.9 1280.3 1294.5 1285.4 1289.4 1291.3 1323.1 1323.9 7861.9 7904.8 7953.8 7957.7 7964.1 489.9 493.6 497.9 500.7 505.5 5932.5 5989.5 6008.9 6010.3 6021.9 9774.1 10509.0 10524.1 10564.7 10569.3 9948.6 10294.7 10364.9 10452.7 10463.6 7581.1 8111.5 8116.6 8122.4 8208.7 7502.5 7535.8 7589.2 7591.7 7620.0 9099.3 9296.9 9494.3 9497.3 9502.7 9462.1 9691.7 9699.6 9770.1 9825.8 6030.2 6542.8 6752.6 7289.5 7358.4 7858.7 7863.6 7919.3 7930.0 7952.8 6894.2 6949.7 6982.1 7100.1 7110.2 6251.8 6516.8 6846.1 6941.4 6964.2 7314.8 7321.0 7365.9 7447.1 7497.6 6752.7 6755.4 6807.6 6815.4 6820.4 6647.0 6837.6 6899.4 6902.4 6906.9 13:25:39 INFO - PROCESS | 1667 | 13:25:39 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5627.07 Median:6455.53 stddev:1820.07 (28.2%) stddev-sans-first:1779.96 13:25:39 INFO - PROCESS | 1667 | Values: 255.3 309.4 312.5 313.6 317.7 5138.5 6466.0 6525.3 6527.6 6593.7 6451.6 6459.5 6484.1 6495.9 6507.6 4607.3 4652.0 4665.4 4675.3 4678.3 4658.9 4668.4 4766.4 4783.0 4800.6 4680.3 4702.9 4721.6 4721.7 4739.1 4493.2 4711.0 4727.7 4749.7 4768.4 3544.6 3864.3 3946.3 4050.4 4053.1 6190.2 6190.4 6213.8 6234.8 6238.1 5527.6 5530.6 5537.3 5543.3 5558.5 5555.6 6895.3 6911.2 6914.6 6915.4 4239.5 4504.3 4515.5 4517.9 4524.5 7111.9 7269.7 7309.5 7326.3 7332.8 3570.3 4461.5 4465.0 4474.6 4481.2 4557.1 4561.5 4564.0 4566.9 4581.9 5434.3 5435.6 5440.0 5448.4 5457.1 6650.1 6970.0 6974.2 6975.7 6990.5 1552.1 1556.5 1571.6 1573.2 1579.6 995.6 1002.7 1013.4 1020.7 1021.5 6165.6 6251.4 6361.5 6395.4 6418.3 7069.9 7140.6 7144.1 7157.4 7218.7 6463.7 6473.4 6473.8 6476.6 6479.6 3771.7 3818.8 3820.1 3820.9 3825.2 7301.5 7462.3 7558.4 7577.5 7618.4 5978.8 7461.4 7462.4 7485.0 7487.3 7532.9 7535.0 7544.2 7545.0 7548.0 7169.4 7195.9 7205.7 7211.6 7223.5 6814.8 7061.9 7096.8 7165.7 7174.7 6989.2 7481.0 7595.4 7607.4 7612.9 4628.6 4699.7 4708.0 4708.5 4722.6 5483.7 7132.8 7132.9 7148.2 7161.1 6617.9 6808.0 6872.8 6901.6 6933.8 6831.3 6853.0 6865.8 6884.3 6889.4 6701.5 6717.6 6727.9 6733.7 6736.1 6873.7 6891.6 6897.3 6920.2 6931.4 5890.7 6295.6 6533.1 6681.8 6762.3 13:25:39 INFO - PROCESS | 1667 | 13:25:39 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18814.20 Median:643.51 stddev:27045.85 (4202.9%) stddev-sans-first:27087.17 13:25:39 INFO - PROCESS | 1667 | Values: 607.7 690.9 705.0 734.6 776.6 14679.0 15098.2 15102.0 15108.1 16800.8 15594.0 15679.1 15691.2 15707.4 15707.5 693.9 694.6 704.3 860.6 861.8 705.6 836.2 854.5 856.8 859.5 896.8 897.6 900.4 903.1 903.5 724.6 893.4 893.4 893.5 894.3 542.6 542.7 654.5 666.2 668.7 15101.3 15139.5 15172.9 15176.3 15185.9 12173.8 12175.7 12275.4 12320.4 12457.4 9897.2 9950.9 10060.7 10145.9 10230.3 3043.4 3442.9 3478.8 3490.8 3501.4 85018.0 85123.6 85941.6 87042.1 87562.7 9203.3 9219.7 9273.0 9504.0 9515.9 21019.6 21025.0 21052.7 21056.7 21071.3 7337.4 7377.2 7532.1 7611.2 7670.2 4064.6 4081.3 4082.6 4167.8 4230.5 3569.2 3635.5 3639.1 3639.7 3641.7 620.2 637.5 643.3 643.7 645.3 520.9 568.8 590.8 590.8 607.0 7480.4 8080.4 8152.5 8293.6 8348.0 569.5 571.5 585.1 594.5 616.4 3765.3 3765.5 3782.6 3947.5 3990.6 96663.0 98064.0 98443.0 99493.5 99976.0 71869.9 73594.0 83027.2 83115.0 84345.0 71276.9 71599.0 71889.0 73018.0 73838.0 7674.3 7731.6 7741.5 7793.3 7803.6 47886.8 49985.8 51682.0 52135.0 52207.0 67930.7 72022.6 72583.5 72596.6 73131.3 9842.9 9864.0 10947.2 10952.4 11094.2 11538.9 11888.0 12084.4 12399.9 12559.4 11057.3 11410.3 11487.0 11551.1 11655.0 9192.3 11364.8 11368.6 11414.3 11656.2 10903.7 11163.6 11198.0 11370.0 12266.7 9333.9 9484.2 9675.6 9795.1 9986.4 7685.8 8789.3 9106.8 9115.5 9808.4 13:25:39 INFO - PROCESS | 1667 | -------- Summary: end -------- 13:25:39 INFO - PROCESS | 1667 | 13:25:39 INFO - TEST-INFO | 1667: exit 0 13:25:39 INFO - TEST-OK | dromaeo_css | took 1113313ms 13:25:39 INFO - TEST-START | kraken 13:25:39 INFO - operating with platform_type : mac_ 13:25:39 INFO - Initialising browser for kraken test... 13:25:39 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpiCl62M/profile http://localhost:49272/getInfo.html) 13:25:41 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 13:25:41 INFO - PROCESS | 1673 | colorDepth:24 13:25:41 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 13:25:41 INFO - PROCESS | 1673 | __metrics 13:25:41 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:25:41 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:25:42 INFO - TEST-INFO | 1673: exit 0 13:25:42 INFO - Browser initialized. 13:25:42 INFO - Running cycle 1/1 for kraken test... 13:25:42 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpiCl62M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:25:54 INFO - PROCESS | 1675 | RSS: Main: 244015104 13:25:54 INFO - PROCESS | 1675 | 13:25:56 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 13:25:57 INFO - PROCESS | 1675 | RSS: Main: 290480128 13:25:57 INFO - PROCESS | 1675 | 13:26:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 13:26:00 INFO - PROCESS | 1675 | RSS: Main: 299057152 13:26:00 INFO - PROCESS | 1675 | 13:26:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 13:26:04 INFO - PROCESS | 1675 | RSS: Main: 285257728 13:26:04 INFO - PROCESS | 1675 | 13:26:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 13:26:06 INFO - PROCESS | 1675 | RSS: Main: 289034240 13:26:06 INFO - PROCESS | 1675 | 13:26:09 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:26:09 INFO - PROCESS | 1675 | RSS: Main: 290058240 13:26:09 INFO - PROCESS | 1675 | 13:26:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 13:26:13 INFO - PROCESS | 1675 | RSS: Main: 290918400 13:26:13 INFO - PROCESS | 1675 | 13:26:16 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 13:26:16 INFO - PROCESS | 1675 | RSS: Main: 291397632 13:26:16 INFO - PROCESS | 1675 | 13:26:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 13:26:19 INFO - PROCESS | 1675 | RSS: Main: 291622912 13:26:19 INFO - PROCESS | 1675 | 13:26:21 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:26:22 INFO - PROCESS | 1675 | RSS: Main: 325222400 13:26:22 INFO - PROCESS | 1675 | 13:26:23 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:26:24 INFO - PROCESS | 1675 | RSS: Main: 323670016 13:26:24 INFO - PROCESS | 1675 | 13:26:26 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:26:27 INFO - PROCESS | 1675 | RSS: Main: 330493952 13:26:27 INFO - PROCESS | 1675 | 13:26:29 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:26:30 INFO - PROCESS | 1675 | RSS: Main: 332234752 13:26:30 INFO - PROCESS | 1675 | 13:26:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:26:33 INFO - PROCESS | 1675 | RSS: Main: 333250560 13:26:33 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 13:26:35 INFO - PROCESS | 1675 | RSS: Main: 393523200 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | __start_tp_report 13:26:35 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 13:26:35 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 13:26:35 INFO - PROCESS | 1675 | |i|pagename|runs| 13:26:35 INFO - PROCESS | 1675 | |0;ai-astar;110;106;111;111;110;114;154;119;110;111 13:26:35 INFO - PROCESS | 1675 | |1;audio-beat-detection;157;121;142;161;118;145;134;120;161;118 13:26:35 INFO - PROCESS | 1675 | |2;audio-dft;183;183;185;183;185;183;186;186;181;186 13:26:35 INFO - PROCESS | 1675 | |3;audio-fft;75;77;84;78;55;61;57;80;77;56 13:26:35 INFO - PROCESS | 1675 | |4;audio-oscillator;96;91;127;82;77;91;110;77;78;110 13:26:35 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;116;131;91;86;89;85;90;87;85;85 13:26:35 INFO - PROCESS | 1675 | |6;imaging-darkroom;95;95;95;95;94;95;89;105;150;150 13:26:35 INFO - PROCESS | 1675 | |7;imaging-desaturate;85;85;84;81;88;85;84;87;85;84 13:26:35 INFO - PROCESS | 1675 | |8;json-parse-financial;55;55;56;54;54;52;53;61;55;52 13:26:35 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;66;70;75;77;71;66;67;66;68;68 13:26:35 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;88;74;99;96;104;108;99;80;85;85 13:26:35 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;127;124;121;121;129;120;116;138;156;132 13:26:35 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;138;126;136;136;138;126;137;166;135;137 13:26:35 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;67;67;66;67;66;66;68;67;66;67 13:26:35 INFO - PROCESS | 1675 | __end_tp_report 13:26:35 INFO - PROCESS | 1675 | __start_cc_report 13:26:35 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1213 13:26:35 INFO - PROCESS | 1675 | __end_cc_report 13:26:35 INFO - PROCESS | 1675 | __startTimestamp1456953995456__endTimestamp 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | ------- Summary: start ------- 13:26:35 INFO - PROCESS | 1675 | Number of tests: 14 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:115.60 Median:111.00 stddev:13.90 (12.5%) stddev-sans-first:14.59 13:26:35 INFO - PROCESS | 1675 | Values: 110.0 106.0 111.0 111.0 110.0 114.0 154.0 119.0 110.0 111.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:143.50 stddev:17.99 (12.5%) stddev-sans-first:17.67 13:26:35 INFO - PROCESS | 1675 | Values: 157.0 121.0 142.0 161.0 118.0 145.0 134.0 120.0 161.0 118.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:184.10 Median:185.00 stddev:1.73 (0.9%) stddev-sans-first:1.79 13:26:35 INFO - PROCESS | 1675 | Values: 183.0 183.0 185.0 183.0 185.0 183.0 186.0 186.0 181.0 186.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:70.00 Median:77.00 stddev:11.32 (14.7%) stddev-sans-first:11.86 13:26:35 INFO - PROCESS | 1675 | Values: 75.0 77.0 84.0 78.0 55.0 61.0 57.0 80.0 77.0 56.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:80.00 stddev:17.00 (21.2%) stddev-sans-first:18.01 13:26:35 INFO - PROCESS | 1675 | Values: 96.0 91.0 127.0 82.0 77.0 91.0 110.0 77.0 78.0 110.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:94.50 Median:86.50 stddev:15.83 (18.3%) stddev-sans-first:14.76 13:26:35 INFO - PROCESS | 1675 | Values: 116.0 131.0 91.0 86.0 89.0 85.0 90.0 87.0 85.0 85.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:106.30 Median:95.00 stddev:23.36 (24.6%) stddev-sans-first:24.41 13:26:35 INFO - PROCESS | 1675 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 89.0 105.0 150.0 150.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.87 (2.2%) stddev-sans-first:1.99 13:26:35 INFO - PROCESS | 1675 | Values: 85.0 85.0 84.0 81.0 88.0 85.0 84.0 87.0 85.0 84.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:2.58 (4.7%) stddev-sans-first:2.74 13:26:35 INFO - PROCESS | 1675 | Values: 55.0 55.0 56.0 54.0 54.0 52.0 53.0 61.0 55.0 52.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:3.89 (5.6%) stddev-sans-first:3.93 13:26:35 INFO - PROCESS | 1675 | Values: 66.0 70.0 75.0 77.0 71.0 66.0 67.0 66.0 68.0 68.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:86.50 stddev:11.03 (12.8%) stddev-sans-first:11.62 13:26:35 INFO - PROCESS | 1675 | Values: 88.0 74.0 99.0 96.0 104.0 108.0 99.0 80.0 85.0 85.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:128.00 stddev:11.65 (9.1%) stddev-sans-first:12.35 13:26:35 INFO - PROCESS | 1675 | Values: 127.0 124.0 121.0 121.0 129.0 120.0 116.0 138.0 156.0 132.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.50 Median:137.00 stddev:11.00 (8.0%) stddev-sans-first:11.66 13:26:35 INFO - PROCESS | 1675 | Values: 138.0 126.0 136.0 136.0 138.0 126.0 137.0 166.0 135.0 137.0 13:26:35 INFO - PROCESS | 1675 | 13:26:35 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 13:26:35 INFO - PROCESS | 1675 | Values: 67.0 67.0 66.0 67.0 66.0 66.0 68.0 67.0 66.0 67.0 13:26:35 INFO - PROCESS | 1675 | -------- Summary: end -------- 13:26:35 INFO - PROCESS | 1675 | 13:26:36 INFO - TEST-INFO | 1675: exit 0 13:26:36 INFO - TEST-OK | kraken | took 56501ms 13:26:36 INFO - SUITE-END | took 1169s 13:26:36 INFO - Completed test suite (00:19:30) 13:26:36 INFO - Working with test: dromaeo_css 13:26:36 INFO - Generating results file: dromaeo_css 13:26:36 INFO - Working with test: kraken 13:26:36 INFO - Generating results file: kraken 13:26:36 INFO - javascript benchmark 13:26:36 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:26:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 13:26:36 INFO - process_Request line: dromaeo_css 7359.00 graph.html#tests=[[72,64,59]] 13:26:36 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:26:36 INFO - process_Request line: kraken 1435.40 graph.html#tests=[[232,64,59]] 13:26:36 INFO - RETURN: dromaeo_css: 7359.00 13:26:36 INFO - RETURN: kraken: 1435.40 13:26:36 INFO - javascript benchmark 13:26:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3411.471221960597, 3417.948730769039, 3459.8443070061844, 3460.446328587426, 3492.4586689063203, 5563.332400111982, 5575.526080283175, 5585.245991791107, 5619.325680918296, 5646.520045796102, 5587.3015873015875, 5640.182173584828, 5693.544516438686, 5776.855578610537, 5802.709864506779, 5058.2412638104215, 5093.719845408501, 5118.820841270556, 5125.282460455539, 5250.238715386286, 5198.45416231296, 5212.113940630083, 5272.578193744491, 5284.8150314739, 5330.760115794779, 5075.771590278447, 5080.136376815932, 5168.9224661630105, 5177.637565370425, 5178.197379406198, 5165.380154381461, 5166.354205724285, 5180.792768289264, 5187.584993200535, 5189.532942035235, 5098.694078355274, 5107.642465027449, 5155.149400348938, 5173.224016397533, 5177.404598471187, 5454.34547854256, 5553.916691249635, 5601.831945041656, 5603.691796951166, 5606.971965140148, 6099.128199784669, 6117.449429551317, 6126.969365153146, 6131.632102073845, 6136.17161683176, 6083.1186467757125, 6130.662813545253, 6162.044883043135, 6171.166892469504, 6187.412195841388, 5705.400932902068, 5718.027935251017, 5761.53907687384, 5774.0761478163295, 5790.68151251681, 6164.7842325518395, 6166.9383306167265, 6174.44430001302, 6175.475084617858, 6178.351273116348, 5975.52195824333, 6033.577649564576, 6086.847828804227, 6100.267967843798, 6128.295246046672, 6129.601575897553, 6202.81391558254, 6203.31763506014, 6240.781572644935, 6256.843578910563, 6117.174181485531, 6141.57009009374, 6167.753289868445, 6175.166352542349, 6198.690065496798, 6002.849928751816, 6122.8251069701855, 6128.816135515942, 6152.661603611755, 6179.938200617937, 4829.9034019319415, 4831.4202295724735, 4843.321934929113, 4860.78126484302, 4900.852974410774, 4344.23975804233, 4353.368761529624, 4367.148406060787, 4367.47590289161, 4388.5611438856495, 5464.508194262536, 5545.251391062236, 5566.0, 5570.248016517799, 5643.971780141155, 6193.876122477525, 6198.101275315144, 6203.751849925952, 6211.875762484725, 6222.253329600477, 5579.38626751057, 5587.916181257285, 5601.383847776741, 5605.495505404533, 5617.354004289477, 5196.402413722471, 5287.603429742785, 5311.123664595299, 5351.51836334724, 5372.677639341574, 6253.937460625336, 6260.968695156495, 6262.029385445263, 6263.217097862767, 6271.435570798559, 5279.498447647467, 6122.561198118349, 6205.627662340274, 6206.937930620636, 6211.3167551570195, 5275.366955965309, 6148.616561273678, 6195.969020155051, 6248.812535623939, 6283.717232724447, 6063.605865618721, 6088.056351265561, 6107.755689772359, 6119.663418511846, 6128.571000029955, 6039.4262545058145, 6189.164462797645, 6208.441240288395, 6219.782307619212, 6226.875462490634, 5967.254093238345, 6009.54928380382, 6029.487493563096, 6055.818325450244, 6088.056351265561, 5725.6850873202375, 5914.083317085859, 5930.0, 5931.258592675916, 5937.495312898452, 5694.857628559319, 5789.218455508452, 5810.94189058104, 5821.417858214314, 5855.531557475307, 6052.788152414644, 6078.088286757022, 6081.422264884829, 6101.908471372844, 6114.296855861633, 5805.3614102447855, 5852.707364631837, 5858.502027327554, 5858.648481091148, 5870.471657550841], "unit": "score", "name": "dojo.html", "value": 5628.999540677106}, {"lowerIsBetter": false, "replicates": [455.8541266794627, 567.6008638705592, 580.3181262017129, 626.3485974586429, 627.1815281058219, 30709.925152619635, 30713.692863071334, 30750.0, 38016.619833801655, 38412.0, 40892.0, 41328.0, 41406.378904316385, 41446.17107657845, 41742.58257417425, 9551.188149007343, 9785.804283914318, 9789.510524473784, 9790.461524616143, 9816.460094694788, 9442.291828112919, 9595.328327017112, 9601.663941762039, 9604.3757155785, 9612.279079069098, 9561.904380956172, 9660.468674222915, 9661.227101831837, 9782.755431114208, 9806.362586431895, 9672.0, 9747.90252097477, 9753.46355950419, 9756.0, 9776.413415195075, 9617.71146865595, 9768.0, 9769.755756106084, 9786.461744604045, 9800.0, 39683.64270823431, 39946.800265998485, 39959.20081598381, 40007.19985600301, 40148.59479918189, 3068.9693103068907, 3090.2428904918215, 3129.4679904416303, 3132.7493800495904, 3602.9279414411567, 28279.151625451064, 28995.0, 29075.418491630047, 29750.10749677513, 29916.80332786686, 2720.986395068032, 2758.3379988802744, 2759.103291430293, 2791.4556661451024, 2843.1044221070297, 472849.0, 474403.0, 475473.0, 477165.0, 479796.0, 59177.11234331488, 59864.40135598675, 60223.698881506185, 60234.39765602376, 60493.69753151206, 64601.67699161474, 64617.0, 64747.67626161839, 64757.0, 64856.67571662112, 16204.189790510427, 16354.100524471269, 16408.343666253215, 16416.0, 16448.75326870098, 10514.0, 12496.81254781179, 12618.684532886751, 12623.179493332904, 12627.305498197504, 18157.140126170703, 19234.903825480782, 19273.4217973461, 19522.70715939262, 19551.80448195528, 8000.279974802179, 8092.433529652868, 8213.260806527322, 8215.219554142346, 8247.422680412314, 729.2580097003239, 851.2721623012359, 913.4015472922385, 995.5022488755623, 1114.4650567727374, 25905.870470647526, 26966.460670786473, 27576.586351204747, 27749.722502774715, 27786.0, 1038.5638032026568, 1045.9215558833118, 1049.7008352619466, 1052.1319911073394, 1141.155544896787, 13944.58166255014, 14092.295385230698, 14184.574462766133, 14246.572602821932, 14310.642233944234, 502477.0, 513310.0, 517790.0, 518891.0, 519765.0, 56671.0, 56825.57936051549, 56830.0, 56954.0, 57092.0, 1291.9935400322938, 1399.9930000350137, 1418.6169734171922, 1420.5454254638416, 1443.1052747296744, 26745.197644070708, 27816.86091569529, 27896.0, 28556.57165142566, 28616.284592885346, 43804.90487737832, 43997.94023687317, 44270.335944961495, 44333.11333773242, 44343.44797932057, 314027.0, 315497.0, 317048.0, 317845.0, 318863.0, 28104.0, 31832.0, 32701.836490817393, 32717.509237361934, 32719.672803271664, 40105.79947100246, 40593.1881362377, 40692.593074070064, 40792.38811417772, 40830.0, 33824.98525044253, 34471.655283446846, 34836.65163348334, 35122.64877351194, 35350.46974295336, 29129.563056553743, 34945.47581786224, 35364.0, 35681.64318356783, 35929.1017724559, 34631.65368346284, 34901.9529414118, 35084.64915350814, 35667.0, 35931.28137437184, 30097.79608815623, 30949.845250773604, 31063.37873242477, 31093.689063109985, 31113.222169445944, 23587.93854276596, 23607.64588531208, 23816.16643417472, 24027.759722402552, 24044.51910961736], "unit": "score", "name": "ext.html", "value": 18944.10593605912}, {"lowerIsBetter": false, "replicates": [300.54617527533424, 355.17599169925785, 358.20121129880374, 360.9440536716808, 368.29655358265717, 19379.031048447574, 19464.63747537673, 21151.875384300067, 21172.364829055114, 21262.362129136112, 15233.77149342758, 16481.67036659266, 20233.59532809343, 20263.898680506576, 20289.0, 5805.448482394177, 6081.270247570298, 6121.540884433663, 6155.353687862777, 6164.476019538344, 3698.7780733156096, 4426.645868330542, 4474.709143905636, 4481.3726078349055, 5968.253968253968, 6553.049807777869, 6556.901646475307, 6558.93441065588, 6566.080748695186, 6582.967085164568, 6209.285932117819, 6503.187101612299, 6510.056041873901, 6511.38141876521, 6520.902186467207, 5621.241132447149, 5635.408282130399, 5650.63270887391, 5652.236948012007, 5654.491095801356, 23577.0, 24949.875250623812, 25121.874390628112, 25727.871360643265, 25764.355891102685, 1987.28457755208, 2196.5826492966285, 2294.0, 2413.915512957038, 2637.222019504251, 9934.205263578897, 9981.251406144569, 10053.698389048268, 10130.949345253226, 10260.076593106656, 1698.8301169883036, 1731.6796392667397, 1768.6462707458559, 1801.9984718735484, 1888.2447021191497, 104653.0, 106002.99999999923, 108817.91182088156, 109375.0, 111297.44351278192, 11267.38029408374, 11311.660650180507, 11361.14791390649, 11383.203175777782, 11470.88529114715, 13607.11553749023, 13685.79471307931, 13704.725905481835, 13724.93137534306, 13730.51943181984, 8201.753947381589, 8388.0, 8398.244158025807, 8480.406371553932, 8532.829343413097, 8414.11651776567, 8424.15758424165, 8424.747257582283, 8520.74437766868, 8532.786680333042, 4375.496817865923, 4478.753668548196, 4484.260097084009, 4525.094981003813, 4525.705829121097, 1645.7860478138005, 1768.2750072470226, 1772.9113544322731, 1878.7839398469077, 1889.1970912362465, 884.3588398411229, 885.3050355471053, 926.5413620258015, 1016.0230524562953, 1017.6133069433716, 18871.18266797756, 20038.398848034583, 20076.59846803056, 20148.0, 20162.495937601678, 860.8665656823202, 906.8911730592239, 928.7770934975692, 938.6252780465434, 951.509972364233, 8366.623501942306, 10223.539940702687, 10345.172386209086, 10359.378437293786, 10590.629327973484, 498496.0, 502677.0, 504720.4763976157, 558373.0, 624909.0, 99303.50348248357, 111928.88071119347, 112537.43731281291, 125979.0, 131345.0, 1005.7938122684832, 1039.2361614213546, 1053.841923711434, 1054.4569546683465, 1058.2327812335996, 15418.383264669288, 17732.0, 18638.81361186425, 18695.439136825917, 18787.624247515247, 36873.63126368702, 48170.55488335356, 48963.0, 49143.262851057974, 49486.76283092952, 70347.64826175837, 71959.0, 72167.63916180386, 72517.0, 72531.27468725457, 7809.0, 7944.8877157196885, 8011.595072094453, 8039.5176289422825, 8184.672613095409, 9379.577918993526, 12716.872831271568, 13054.08621396493, 13114.540991065267, 13147.882429993557, 5653.632513886584, 10942.17933654995, 11359.04256646486, 11402.144839137263, 11434.199606027498, 9462.858057129286, 11395.772084558428, 11490.0, 11681.824772628588, 11723.941380293043, 11333.773324533298, 11494.885051149382, 11536.826947595624, 11558.364289964133, 11825.231359961575, 7968.641411136628, 8071.838563228585, 8135.959320203598, 8222.876656850272, 8374.2881855043, 9250.95374523123, 10463.372197668165, 11226.0, 11390.145739069769, 11568.595099171489], "unit": "score", "name": "jquery.html", "value": 9274.615406319763}, {"lowerIsBetter": false, "replicates": [1349.156777014366, 1523.3754160794074, 1551.2786554252275, 1779.2616064333301, 1930.382277671145, 7805.219478052199, 8327.583620818958, 8453.535055571941, 8476.067632560429, 8531.402801803884, 8172.1827817218245, 8440.987081550207, 8442.113578074306, 8446.746597602067, 8450.873236901436, 2120.215520257507, 2332.778386053331, 2375.619900815874, 2409.409694624819, 2417.407735104893, 2397.436602398435, 2408.0488207158164, 2408.5544174327806, 2410.0600765701392, 2410.120306088274, 2343.4727186383097, 2360.7875291223786, 2366.928992130239, 2408.434018005767, 2409.638554216864, 2363.397333679901, 2400.567897778399, 2408.9759102408925, 2417.9637305440433, 2435.281591930367, 2329.1615018593293, 2338.75443078476, 2363.1256435118944, 2364.219807463533, 2367.4673198530363, 8485.703000394957, 8586.570671466401, 8586.914130858673, 8597.18326758957, 8602.655893764242, 5262.6843289177705, 5420.593455490854, 5423.0, 5429.755660995225, 5431.180554514242, 3509.175343794206, 3591.964080359189, 3659.1035196376793, 3663.0, 3672.8714494992814, 1038.5015192707542, 1053.8893416191265, 1058.4654749351528, 1065.3767545985609, 1068.8289873620183, 11275.887241127566, 11424.543018279259, 11430.028447581966, 11440.19918605698, 11465.197436179471, 4704.29435584665, 4784.64115191362, 4788.928166077511, 4826.493218212107, 4864.881077352229, 9898.356606820533, 9902.851457228147, 9911.207103431709, 9919.752006199902, 9925.15636170919, 5344.43883392246, 5360.3031605891765, 5368.865778355573, 5369.946300537023, 5373.0, 4364.912701745948, 4502.482214545304, 4692.741899195509, 4805.063012712488, 4873.26900964851, 3804.8097595120134, 3855.306044911943, 3872.7482713623526, 3886.378179491268, 3938.271419787291, 1243.7885559454915, 1269.3399432295155, 1271.9364031798373, 1280.3150314581653, 1294.5145570411096, 1285.4279845468864, 1289.3939848271298, 1291.309149604957, 1323.0540163782941, 1323.8543760186371, 7861.882071768814, 7904.762857114296, 7953.840923181504, 7957.721479748181, 7964.084130324971, 489.9142650036229, 493.580456611877, 497.8805086779219, 500.74712270303263, 505.47683147941706, 5932.495737862244, 5989.460948514655, 6008.909866352008, 6010.278766548042, 6021.939780602225, 9774.12032917041, 10509.0, 10524.105451036594, 10564.735881602868, 10569.312994655324, 9948.602055917827, 10294.742631434125, 10364.948175259075, 10452.68641940743, 10463.633772817915, 7581.128170260491, 8111.472754270953, 8116.553589552631, 8122.431429799857, 8208.712695055645, 7502.474826762074, 7535.8492830141995, 7589.241075892367, 7591.696332146652, 7620.047494063242, 9099.317551183556, 9296.860547091665, 9494.28792840526, 9497.287703422133, 9502.714918552454, 9462.053794620759, 9691.67399824023, 9699.6120155193, 9770.120689138012, 9825.803483930424, 6030.185924900083, 6542.771003014872, 6752.628605426748, 7289.489735718449, 7358.374538164316, 7858.685652573833, 7863.646135924012, 7919.326857217201, 7929.960350198212, 7952.84094318122, 6894.172699276119, 6949.722011119498, 6982.057422248135, 7100.147982242164, 7110.182329032227, 6251.78118765841, 6516.837079073061, 6846.144231971004, 6941.409980151541, 6964.233934267125, 7314.780556583311, 7321.048263725682, 7365.889511657437, 7447.069116360455, 7497.587632680255, 6752.729890804313, 6755.4257888080065, 6807.591544507345, 6815.352541508549, 6820.35206655367, 6647.0, 6837.555558888656, 6899.413549848118, 6902.413294869792, 6906.8618627628175], "unit": "score", "name": "mootools.html", "value": 4702.135778974688}, {"lowerIsBetter": false, "replicates": [255.2864743043194, 309.4445470380667, 312.49220017471595, 313.64244760972485, 317.7013607209222, 5138.460461651529, 6466.030095485674, 6525.347465253472, 6527.608343499393, 6593.703283352249, 6451.580647257925, 6459.483241340693, 6484.092227088199, 6495.935040649604, 6507.6095434273975, 4607.262837945921, 4652.023075154221, 4665.393498845146, 4675.322078298645, 4678.251479763238, 4658.930116048262, 4668.393108895839, 4766.404199475066, 4782.952170478303, 4800.591949684281, 4680.274557443602, 4702.90594188116, 4721.622270218374, 4721.669483136165, 4739.123262196505, 4493.168763778712, 4711.0, 4727.7163370197895, 4749.691270067435, 4768.427788665348, 3544.6428125296648, 3864.265789499986, 3946.269940061069, 4050.3924411338535, 4053.1285773558825, 6190.164327815733, 6190.350013248634, 6213.844653883644, 6234.781782637631, 6238.1266622672865, 5527.640703354309, 5530.640508366943, 5537.252470916415, 5543.279373681396, 5558.470895742427, 5555.638883472561, 6895.34494223048, 6911.2397636260475, 6914.582510585318, 6915.377616014533, 4239.47006624172, 4504.279315309567, 4515.525869783658, 4517.921755992247, 4524.502304746476, 7111.928880711178, 7269.745558905466, 7309.5248808827255, 7326.2673732626845, 7332.78001659951, 3570.2680950405106, 4461.486929003141, 4464.977675111603, 4474.6420286377015, 4481.193385190697, 4557.134144512532, 4561.521040290788, 4564.018735971782, 4566.885827854264, 4581.931271030937, 5434.2935418395355, 5435.592330575223, 5439.972800135974, 5448.42791506894, 5457.126859702428, 6650.135482387259, 6969.954506824017, 6974.197967233732, 6975.720971161097, 6990.545614535039, 1552.1230504764771, 1556.5252597957506, 1571.6070982254437, 1573.1583602772462, 1579.6445799694977, 995.6266400099962, 1002.7042022603349, 1013.3869009249445, 1020.7039958412125, 1021.5403068619003, 6165.599236049642, 6251.374862513712, 6361.459275961595, 6395.42441180296, 6418.26189988148, 7069.92930070703, 7140.642967851587, 7144.142702875688, 7157.391621712213, 7218.67515961783, 6463.6768161591735, 6473.385028422293, 6473.805785826433, 6476.643784591798, 6479.5788273763, 3771.73597848148, 3818.7899665518107, 3820.121372084436, 3820.9235815284096, 3825.2349530093534, 7301.502276545536, 7462.291082347168, 7558.395328373717, 7577.469577129548, 7618.352440042659, 5978.790742323998, 7461.440391970624, 7462.440316976248, 7484.962575187089, 7487.288707572772, 7532.887006694904, 7534.962325188559, 7544.170141284454, 7545.0, 7547.962260188664, 7169.426445884213, 7195.8920616191845, 7205.747798827016, 7211.567305961659, 7223.494355395072, 6814.829629259309, 7061.940708893707, 7096.822579435349, 7165.713371465083, 7174.748883789042, 6989.161300643956, 7481.0, 7595.430342724208, 7607.429442791702, 7612.885806713015, 4628.583427491542, 4699.718016918996, 4708.0, 4708.529147085401, 4722.574968252874, 5483.670979741229, 7132.750353737594, 7132.928670713226, 7148.17795953472, 7161.104861892263, 6617.867642647217, 6807.965960170168, 6872.759453419107, 6901.585904845725, 6933.826654333682, 6831.316868313129, 6853.0405743195, 6865.759698410531, 6884.277150899084, 6889.414399775875, 6701.530892837454, 6717.596944183365, 6727.8990815138795, 6733.69698363565, 6736.056952026818, 6873.656317184221, 6891.552049116792, 6897.310268973062, 6920.204176519765, 6931.376176144171, 5890.7349169288345, 6295.5907865988565, 6533.118029066205, 6681.832954176184, 6762.323767623198], "unit": "score", "name": "prototype.html", "value": 5008.158089833948}, {"lowerIsBetter": false, "replicates": [607.7356349987756, 690.8618276344725, 704.982375440614, 734.6106563521332, 776.5651235308228, 14678.972471926969, 15098.245087745623, 15102.0, 15108.093514389131, 16800.83199168008, 15593.986390884584, 15679.137647429416, 15691.21543922805, 15707.371705131782, 15707.528774136767, 693.9375456208941, 694.6040756768643, 704.3027402871172, 860.604122103833, 861.7974775927652, 705.6224919667978, 836.2306677856386, 854.5171977832536, 856.7986523167051, 859.5186695450536, 896.8206358728248, 897.6095398501673, 900.3697411811726, 903.0608167505786, 903.5391950105461, 724.6413025552386, 893.3746377535718, 893.3835653399134, 893.4683863101444, 894.3203165594131, 542.6499907559602, 542.734060310449, 654.4829584628138, 666.1839246922481, 668.6957434367351, 15101.3204405802, 15139.54581362561, 15172.924135379362, 15176.317065732068, 15185.924070379688, 12173.756524869541, 12175.695607609792, 12275.386230688518, 12320.383980801014, 12457.377131143498, 9897.15874150698, 9950.900490995142, 10060.748481288027, 10145.949270253675, 10230.335028223142, 3043.360894212218, 3442.9200103546555, 3478.773879697837, 3490.7730997485082, 3501.3872572299747, 85018.0, 85123.5743821277, 85941.57029214877, 87042.12957870467, 87562.68655970166, 9203.309751768644, 9219.677311294072, 9273.0, 9503.952480237554, 9515.857262141073, 21019.579608407745, 21025.0, 21052.684209736864, 21056.684149737765, 21071.26250581222, 7337.449691273176, 7377.188509263977, 7532.058492688414, 7611.20082391352, 7670.232976702285, 4064.6138616831354, 4081.3061779497557, 4082.6121518455698, 4167.812448439828, 4230.49234091911, 3569.196930690626, 3635.527381440396, 3639.1448009717697, 3639.6724294813594, 3641.726870484671, 620.221621864557, 637.5218586060455, 643.2698886763557, 643.7489379142045, 645.283735054099, 520.8984248071665, 568.7753337431691, 590.7666471743723, 590.8360529756374, 607.0257237134424, 7480.364169045583, 8080.39397045224, 8152.51084934894, 8293.585320733939, 8347.996480844553, 569.481771587853, 571.5399103721461, 585.1106318396099, 594.4590422715395, 616.4328817487922, 3765.3034188674633, 3765.5293088363956, 3782.6217378261954, 3947.486826712509, 3990.6408423242046, 96663.0, 98064.01935980549, 98443.0, 99493.50253248688, 99976.0, 71869.92195117078, 73594.0, 83027.16972830195, 83115.0, 84345.0, 71276.86169414927, 71599.0, 71889.0, 73018.0, 73837.99999999892, 7674.309312161932, 7731.613419328898, 7741.497142400411, 7793.2596403341595, 7803.648835802289, 47886.76056619694, 49985.75007124941, 51682.0, 52135.0, 52207.0, 67930.66034669992, 72022.63988680023, 72583.54832903207, 72596.63701681458, 73131.26868731457, 9842.852357214504, 9863.950680246553, 10947.15374002749, 10952.397618131079, 11094.243019586755, 11538.94230528842, 11887.989520890475, 12084.39578021113, 12399.876001240233, 12559.43482543306, 11057.336559806437, 11410.315381077162, 11487.0, 11551.133664974992, 11655.0, 9192.257169058525, 11364.829527557258, 11368.602098926498, 11414.258073225546, 11656.18406711522, 10903.727406814893, 11163.553457861595, 11198.048165905664, 11370.033547148585, 12266.693332666755, 9333.906660933575, 9484.241260699266, 9675.612975480903, 9795.06946840049, 9986.35088719231, 7685.807854803675, 8789.296856251356, 9106.817863642822, 9115.515845621327, 9808.411495310018], "unit": "score", "name": "yui.html", "value": 6818.684946123134}], "name": "dromaeo_css", "value": 7358.993819104871}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 111.0, 111.0, 110.0, 114.0, 154.0, 119.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 115.6}, {"lowerIsBetter": true, "replicates": [157.0, 121.0, 142.0, 161.0, 118.0, 145.0, 134.0, 120.0, 161.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 137.7}, {"lowerIsBetter": true, "replicates": [183.0, 183.0, 185.0, 183.0, 185.0, 183.0, 186.0, 186.0, 181.0, 186.0], "unit": "score", "name": "audio-dft", "value": 184.1}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 84.0, 78.0, 55.0, 61.0, 57.0, 80.0, 77.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.0}, {"lowerIsBetter": true, "replicates": [96.0, 91.0, 127.0, 82.0, 77.0, 91.0, 110.0, 77.0, 78.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 93.9}, {"lowerIsBetter": true, "replicates": [116.0, 131.0, 91.0, 86.0, 89.0, 85.0, 90.0, 87.0, 85.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 89.0, 105.0, 150.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 106.3}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 81.0, 88.0, 85.0, 84.0, 87.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 84.8}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 56.0, 54.0, 54.0, 52.0, 53.0, 61.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.7}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 75.0, 77.0, 71.0, 66.0, 67.0, 66.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [88.0, 74.0, 99.0, 96.0, 104.0, 108.0, 99.0, 80.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.8}, {"lowerIsBetter": true, "replicates": [127.0, 124.0, 121.0, 121.0, 129.0, 120.0, 116.0, 138.0, 156.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.4}, {"lowerIsBetter": true, "replicates": [138.0, 126.0, 136.0, 136.0, 138.0, 126.0, 137.0, 166.0, 135.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 68.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1435.4}]} 13:26:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1435.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7359.00"}}} 13:26:36 INFO - Return code: 0 13:26:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:26:36 INFO - # TBPL SUCCESS # 13:26:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:26:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:26:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:26:36 INFO - 2016-03-02 13:26:36.836 screenresolution[1679:10178] starting screenresolution argv=screenresolution get 13:26:36 INFO - 2016-03-02 13:26:36.838 screenresolution[1679:10178] Display 0: 1600x1200x32@60 13:26:36 INFO - 2016-03-02 13:26:36.844 screenresolution[1680:10181] starting screenresolution argv=screenresolution list 13:26:36 INFO - Available Modes on Display 0 13:26:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:26:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:26:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:26:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:26:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:26:37 INFO - Intel Iris: 13:26:37 INFO - Chipset Model: Intel Iris 13:26:37 INFO - Type: GPU 13:26:37 INFO - Bus: Built-In 13:26:37 INFO - VRAM (Dynamic, Max): 1536 MB 13:26:37 INFO - Vendor: Intel (0x8086) 13:26:37 INFO - Device ID: 0x0a2e 13:26:37 INFO - Revision ID: 0x0009 13:26:37 INFO - Displays: 13:26:37 INFO - Display: 13:26:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:26:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:26:37 INFO - Display Serial Number: 1600x1200 60 13:26:37 INFO - Main Display: Yes 13:26:37 INFO - Mirror: Off 13:26:37 INFO - Online: Yes 13:26:37 INFO - Rotation: Supported 13:26:37 INFO - Return code: 0 13:26:37 INFO - Running post-action listener: _resource_record_post_action 13:26:37 INFO - Running post-run listener: _resource_record_post_run 13:26:38 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 33730048; Write bytes: 705482240; Read time: 351; Write time: 1861 13:26:38 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401400320; Write bytes: 402892288; Read time: 30167; Write time: 692 13:26:38 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 31948288; Write bytes: 300926976; Read time: 333; Write time: 1164 13:26:38 INFO - Running post-run listener: _upload_blobber_files 13:26:38 INFO - Blob upload gear active. 13:26:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:26:38 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:26:38 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:26:38 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:26:38 INFO - (blobuploader) - INFO - Open directory for files ... 13:26:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:26:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:39 INFO - (blobuploader) - INFO - Done attempting. 13:26:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:26:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:26:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:40 INFO - (blobuploader) - INFO - Done attempting. 13:26:40 INFO - (blobuploader) - INFO - Iteration through files over. 13:26:40 INFO - Return code: 0 13:26:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:26:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:26:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7d0acca0dd548860045998a3c9eeb009cfffe908a408d1fdb487eedd88d19757c29d8c3bd54191d96cca76f496278f71a1e11c8e4ce94fbb3d33f7eb355e841", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b5a6b25bbaec476d9427d4c5e01d48615b68a3850db620bb6e7685c9a98f7ef7388bf9516adda264570605acaf615e5948007f36afed5bd76db07020c986fe9"} 13:26:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:26:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:26:40 INFO - Contents: 13:26:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7d0acca0dd548860045998a3c9eeb009cfffe908a408d1fdb487eedd88d19757c29d8c3bd54191d96cca76f496278f71a1e11c8e4ce94fbb3d33f7eb355e841", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b5a6b25bbaec476d9427d4c5e01d48615b68a3850db620bb6e7685c9a98f7ef7388bf9516adda264570605acaf615e5948007f36afed5bd76db07020c986fe9"} 13:26:40 INFO - Running post-run listener: copy_logs_to_upload_dir 13:26:40 INFO - Copying logs to upload dir... 13:26:40 INFO - mkdir: /builds/slave/test/build/upload/logs 13:26:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.370225 ========= master_lag: 1.52 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-03-02 13:26:42.329071) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 13:26:42.332563) ========= 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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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/c7d0acca0dd548860045998a3c9eeb009cfffe908a408d1fdb487eedd88d19757c29d8c3bd54191d96cca76f496278f71a1e11c8e4ce94fbb3d33f7eb355e841", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b5a6b25bbaec476d9427d4c5e01d48615b68a3850db620bb6e7685c9a98f7ef7388bf9516adda264570605acaf615e5948007f36afed5bd76db07020c986fe9"} build_url:https://queue.taskcluster.net/v1/task/b1K7t3v-QUewACx8DsDbjw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/b1K7t3v-QUewACx8DsDbjw/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/c7d0acca0dd548860045998a3c9eeb009cfffe908a408d1fdb487eedd88d19757c29d8c3bd54191d96cca76f496278f71a1e11c8e4ce94fbb3d33f7eb355e841", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b5a6b25bbaec476d9427d4c5e01d48615b68a3850db620bb6e7685c9a98f7ef7388bf9516adda264570605acaf615e5948007f36afed5bd76db07020c986fe9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 13:26:42.369293) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:26:42.369805) ========= 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.1ZYDghtrRk/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.v7kKg5pyBR/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.005105 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 13:26:42.422151) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 13:26:42.422817) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 13:26:42.423647) ========= ========= Total master_lag: 2.62 =========