builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0124 starttime: 1456937576.26 results: success (0) buildid: 20160302053632 builduid: b0613b10680a4bdcb5edb01b98a834fc revision: 1db864e863ed710a3e51ef795b32e070fd9cc145 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.258974) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.259446) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.259728) ========= 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.5RtI0ITUZZ/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.7lB343IyD8/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005725 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.282383) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.282686) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.298859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.299210) ========= 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.5RtI0ITUZZ/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.7lB343IyD8/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005387 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.346715) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.347014) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.347389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.347667) ========= 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.5RtI0ITUZZ/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.7lB343IyD8/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 08:52:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.49M=0.001s 2016-03-02 08:52:56 (9.49 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096970 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.459589) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.459947) ========= 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.5RtI0ITUZZ/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.7lB343IyD8/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.026134 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.507965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:56.508319) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1db864e863ed710a3e51ef795b32e070fd9cc145 --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 1db864e863ed710a3e51ef795b32e070fd9cc145 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5RtI0ITUZZ/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.7lB343IyD8/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 08:52:56,583 truncating revision to first 12 chars 2016-03-02 08:52:56,583 Setting DEBUG logging. 2016-03-02 08:52:56,584 attempt 1/10 2016-03-02 08:52:56,584 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1db864e863ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 08:52:57,197 unpacking tar archive at: fx-team-1db864e863ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.864540 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:57.388690) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:57.389073) ========= echo 1db864e863ed710a3e51ef795b32e070fd9cc145 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1db864e863ed710a3e51ef795b32e070fd9cc145'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5RtI0ITUZZ/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.7lB343IyD8/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 1db864e863ed710a3e51ef795b32e070fd9cc145 program finished with exit code 0 elapsedTime=0.005373 script_repo_revision: '1db864e863ed710a3e51ef795b32e070fd9cc145' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:57.438650) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:57.438955) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:57.451743) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-02 08:52:57.452186) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5RtI0ITUZZ/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.7lB343IyD8/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 08:52:57 INFO - MultiFileLogger online at 20160302 08:52:57 in /builds/slave/test 08:52:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:52:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:57 INFO - {'append_to_log': False, 08:52:57 INFO - 'base_work_dir': '/builds/slave/test', 08:52:57 INFO - 'blob_upload_branch': 'Fx-Team', 08:52:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:57 INFO - 'branch': 'Fx-Team', 08:52:57 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:57 INFO - 'config_files': ('talos/mac_config.py',), 08:52:57 INFO - 'default_actions': ('clobber', 08:52:57 INFO - 'read-buildbot-config', 08:52:57 INFO - 'download-and-extract', 08:52:57 INFO - 'populate-webroot', 08:52:57 INFO - 'create-virtualenv', 08:52:57 INFO - 'install', 08:52:57 INFO - 'run-tests'), 08:52:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:57 INFO - 'download_minidump_stackwalk': True, 08:52:57 INFO - 'download_symbols': 'ondemand', 08:52:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:57 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:57 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:57 INFO - 'installer_path': 'installer.exe', 08:52:57 INFO - 'log_level': 'info', 08:52:57 INFO - 'log_name': 'talos', 08:52:57 INFO - 'log_to_console': True, 08:52:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:52:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:52:57 INFO - 'opt_config_files': (), 08:52:57 INFO - 'pip_index': False, 08:52:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:57 INFO - 'cmd': ('bash', 08:52:57 INFO - '-c', 08:52:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:57 INFO - 'enabled': True, 08:52:57 INFO - 'halt_on_failure': False, 08:52:57 INFO - 'name': 'check_screen_resolution'},), 08:52:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:57 INFO - 'cmd': ('bash', 08:52:57 INFO - '-c', 08:52:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:57 INFO - 'enabled': True, 08:52:57 INFO - 'halt_on_failure': False, 08:52:57 INFO - 'name': 'check_screen_resolution'},), 08:52:57 INFO - 'run_cmd_checks_enabled': True, 08:52:57 INFO - 'sps_profile': False, 08:52:57 INFO - 'sps_profile_interval': 0, 08:52:57 INFO - 'suite': 'dromaeojs-e10s', 08:52:57 INFO - 'system_bits': '32', 08:52:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:57 INFO - 'title': 't-yosemite-r7-0124', 08:52:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:57 INFO - 'use_talos_json': True, 08:52:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:57 INFO - 'work_dir': 'build'} 08:52:57 INFO - ##### 08:52:57 INFO - ##### Running clobber step. 08:52:57 INFO - ##### 08:52:57 INFO - Running pre-action listener: _resource_record_pre_action 08:52:57 INFO - Running main action method: clobber 08:52:57 INFO - rmtree: /builds/slave/test/build 08:52:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:52:59 INFO - Running post-action listener: _resource_record_post_action 08:52:59 INFO - ##### 08:52:59 INFO - ##### Running read-buildbot-config step. 08:52:59 INFO - ##### 08:52:59 INFO - Running pre-action listener: _resource_record_pre_action 08:52:59 INFO - Running main action method: read_buildbot_config 08:52:59 INFO - Using buildbot properties: 08:52:59 INFO - { 08:52:59 INFO - "project": "", 08:52:59 INFO - "product": "firefox", 08:52:59 INFO - "script_repo_revision": "production", 08:52:59 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:52:59 INFO - "repository": "", 08:52:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:52:59 INFO - "buildid": "20160302053632", 08:52:59 INFO - "pgo_build": "False", 08:52:59 INFO - "basedir": "/builds/slave/test", 08:52:59 INFO - "buildnumber": 442, 08:52:59 INFO - "slavename": "t-yosemite-r7-0124", 08:52:59 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:52:59 INFO - "platform": "yosemite_r7", 08:52:59 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:52:59 INFO - "branch": "fx-team", 08:52:59 INFO - "repo_path": "integration/fx-team", 08:52:59 INFO - "revision": "1db864e863ed710a3e51ef795b32e070fd9cc145", 08:52:59 INFO - "stage_platform": "macosx64", 08:52:59 INFO - "builduid": "b0613b10680a4bdcb5edb01b98a834fc", 08:52:59 INFO - "slavebuilddir": "test" 08:52:59 INFO - } 08:52:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 08:52:59 INFO - Running post-action listener: _resource_record_post_action 08:52:59 INFO - ##### 08:52:59 INFO - ##### Running download-and-extract step. 08:52:59 INFO - ##### 08:52:59 INFO - Running pre-action listener: _resource_record_pre_action 08:52:59 INFO - Running main action method: download_and_extract 08:52:59 INFO - mkdir: /builds/slave/test/build/tests 08:52: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')]} 08:52:59 INFO - https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:52:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 08:52:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 08:52:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:52:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:53:01 INFO - Downloaded 1277 bytes. 08:53:01 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 08:53:01 INFO - Using the following test package requirements: 08:53:01 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:53:01 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 08:53:01 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 08:53:01 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'jsshell-mac.zip'], 08:53:01 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 08:53:01 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:53:01 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 08:53:01 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 08:53:01 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 08:53:01 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:53:01 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 08:53:01 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:01 INFO - https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:53:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:53:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:53:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:53:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:53:03 INFO - Downloaded 17851861 bytes. 08:53:03 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'] 08:53:03 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 08:53:06 INFO - Return code: 0 08:53:06 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 08:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:06 INFO - https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:53:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:53:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:53:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:53:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:53:08 INFO - Downloaded 17851861 bytes. 08:53:08 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'] 08:53:08 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 08:53:11 INFO - Return code: 0 08:53:11 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')]} 08:53:11 INFO - https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:53:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:53:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:53:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:53:12 INFO - Downloaded 10808456 bytes. 08:53:12 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'] 08:53:12 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 08:53:13 INFO - Return code: 0 08:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:13 INFO - https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:53:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:53:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:53:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 08:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:53:16 INFO - Downloaded 110968976 bytes. 08:53:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:53:16 INFO - mkdir: /builds/slave/test/properties 08:53:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:16 INFO - Contents: 08:53:16 INFO - build_url:https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:53:17 INFO - Running post-action listener: _resource_record_post_action 08:53:17 INFO - Running post-action listener: set_extra_try_arguments 08:53:17 INFO - ##### 08:53:17 INFO - ##### Running populate-webroot step. 08:53:17 INFO - ##### 08:53:17 INFO - Running pre-action listener: _resource_record_pre_action 08:53:17 INFO - Running main action method: populate_webroot 08:53:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:17 INFO - '--tppagecycles', 08:53:17 INFO - '7'], 08:53:17 INFO - 'tests': ['tsvgm']}}, 08:53:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:53:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:53:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:53:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:53:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:17 INFO - 'talos_options': ['--e10s'], 08:53:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:17 INFO - 'tests': ['damp', 'tps']}, 08:53:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:17 INFO - 'talos_options': ['--e10s'], 08:53:17 INFO - 'tests': ['damp', 'tps']}, 08:53:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:53:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:17 INFO - 'other': {'tests': ['a11yr', 08:53:17 INFO - 'ts_paint', 08:53:17 INFO - 'tpaint', 08:53:17 INFO - 'sessionrestore', 08:53:17 INFO - 'sessionrestore_no_auto_restore']}, 08:53:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:53:17 INFO - 'tests': ['a11yr', 08:53:17 INFO - 'ts_paint', 08:53:17 INFO - 'tpaint', 08:53:17 INFO - 'sessionrestore', 08:53:17 INFO - 'sessionrestore_no_auto_restore']}, 08:53:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:53:17 INFO - 'tests': ['a11yr', 08:53:17 INFO - 'ts_paint', 08:53:17 INFO - 'tpaint', 08:53:17 INFO - 'sessionrestore', 08:53:17 INFO - 'sessionrestore_no_auto_restore']}, 08:53:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:53:17 INFO - 'tests': ['a11yr', 08:53:17 INFO - 'ts_paint', 08:53:17 INFO - 'tpaint', 08:53:17 INFO - 'sessionrestore', 08:53:17 INFO - 'sessionrestore_no_auto_restore']}, 08:53:17 INFO - 'other_l64': {'tests': ['a11yr', 08:53:17 INFO - 'ts_paint', 08:53:17 INFO - 'tpaint', 08:53:17 INFO - 'sessionrestore', 08:53:17 INFO - 'sessionrestore_no_auto_restore']}, 08:53:17 INFO - 'other_nol64': {'tests': ['a11yr', 08:53:17 INFO - 'ts_paint', 08:53:17 INFO - 'tpaint', 08:53:17 INFO - 'sessionrestore', 08:53:17 INFO - 'sessionrestore_no_auto_restore']}, 08:53:17 INFO - 'svgr': {'tests': ['tsvgx', 08:53:17 INFO - 'tsvgr_opacity', 08:53:17 INFO - 'tart', 08:53:17 INFO - 'tscrollx', 08:53:17 INFO - 'cart']}, 08:53:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:53:17 INFO - 'tests': ['tsvgx', 08:53:17 INFO - 'tsvgr_opacity', 08:53:17 INFO - 'tart', 08:53:17 INFO - 'tscrollx', 08:53:17 INFO - 'cart']}, 08:53:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:17 INFO - 'tests': ['tp5o']}, 08:53:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:17 INFO - 'talos_options': ['--e10s'], 08:53:17 INFO - 'tests': ['tp5o']}, 08:53:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:17 INFO - 'talos_options': ['--xperf_path', 08:53:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:17 INFO - 'tests': ['tp5n']}, 08:53:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:17 INFO - 'talos_options': ['--e10s', 08:53:17 INFO - '--xperf_path', 08:53:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:17 INFO - 'tests': ['tp5n']}}, 08:53:17 INFO - 'talos.zip': {'path': '', 08:53:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:17 INFO - Running post-action listener: _resource_record_post_action 08:53:17 INFO - ##### 08:53:17 INFO - ##### Running create-virtualenv step. 08:53:17 INFO - ##### 08:53:17 INFO - Running pre-action listener: _resource_record_pre_action 08:53:17 INFO - Running main action method: create_virtualenv 08:53:17 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:17 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 08:53:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:18 INFO - Using real prefix '/tools/python27' 08:53:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:21 INFO - Installing pip.................done. 08:53:21 INFO - Return code: 0 08:53:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:21 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 0x10df99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82b9da8c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de3dd30>, '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 0x10dc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de34b20>, '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.5RtI0ITUZZ/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.7lB343IyD8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 08:53:21 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 08:53:21 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 08:53:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5RtI0ITUZZ/Render', 08:53:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:21 INFO - 'HOME': '/Users/cltbld', 08:53:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:21 INFO - 'LOGNAME': 'cltbld', 08:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:21 INFO - 'MOZ_NO_REMOTE': '1', 08:53:21 INFO - 'NO_EM_RESTART': '1', 08:53:21 INFO - 'PAGER': '/bin/cat', 08:53:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:21 INFO - 'PWD': '/builds/slave/test', 08:53:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:21 INFO - 'SHELL': '/bin/bash', 08:53:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7lB343IyD8/Listeners', 08:53:21 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 08:53:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:21 INFO - 'USER': 'cltbld', 08:53:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:21 INFO - 'XPC_FLAGS': '0x0', 08:53:21 INFO - 'XPC_SERVICE_NAME': '0', 08:53:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:21 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 08:53:21 INFO - Cleaning up... 08:53:21 INFO - Return code: 0 08:53:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:21 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 0x10df99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82b9da8c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de3dd30>, '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 0x10dc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de34b20>, '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.5RtI0ITUZZ/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.7lB343IyD8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 08:53:21 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 08:53:21 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 08:53:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5RtI0ITUZZ/Render', 08:53:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:21 INFO - 'HOME': '/Users/cltbld', 08:53:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:21 INFO - 'LOGNAME': 'cltbld', 08:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:21 INFO - 'MOZ_NO_REMOTE': '1', 08:53:21 INFO - 'NO_EM_RESTART': '1', 08:53:21 INFO - 'PAGER': '/bin/cat', 08:53:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:21 INFO - 'PWD': '/builds/slave/test', 08:53:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:21 INFO - 'SHELL': '/bin/bash', 08:53:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7lB343IyD8/Listeners', 08:53:21 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 08:53:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:21 INFO - 'USER': 'cltbld', 08:53:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:21 INFO - 'XPC_FLAGS': '0x0', 08:53:21 INFO - 'XPC_SERVICE_NAME': '0', 08:53:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:22 INFO - Downloading/unpacking psutil>=0.7.1 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:24 INFO - Installing collected packages: psutil 08:53:24 INFO - Running setup.py install for psutil 08:53:25 INFO - building 'psutil._psutil_osx' extension 08:53:25 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 08:53:25 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 08:53:25 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 08:53:25 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 08:53:25 INFO - building 'psutil._psutil_posix' extension 08:53:25 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 08:53:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:53:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:53:25 INFO - ^ 08:53:25 INFO - 1 warning generated. 08:53:25 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 08:53:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:26 INFO - Successfully installed psutil 08:53:26 INFO - Cleaning up... 08:53:26 INFO - Return code: 0 08:53:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:53:26 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')]} 08:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:26 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')]} 08:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:26 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 0x10df99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82b9da8c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de3dd30>, '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 0x10dc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de34b20>, '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.5RtI0ITUZZ/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.7lB343IyD8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 08:53:26 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 08:53:26 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 08:53:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5RtI0ITUZZ/Render', 08:53:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:26 INFO - 'HOME': '/Users/cltbld', 08:53:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:26 INFO - 'LOGNAME': 'cltbld', 08:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:26 INFO - 'MOZ_NO_REMOTE': '1', 08:53:26 INFO - 'NO_EM_RESTART': '1', 08:53:26 INFO - 'PAGER': '/bin/cat', 08:53:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:26 INFO - 'PWD': '/builds/slave/test', 08:53:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:26 INFO - 'SHELL': '/bin/bash', 08:53:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7lB343IyD8/Listeners', 08:53:26 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 08:53:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:26 INFO - 'USER': 'cltbld', 08:53:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:26 INFO - 'XPC_FLAGS': '0x0', 08:53:26 INFO - 'XPC_SERVICE_NAME': '0', 08:53:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:53:28 INFO - Installing collected packages: mozsystemmonitor 08:53:28 INFO - Running setup.py install for mozsystemmonitor 08:53:29 INFO - Successfully installed mozsystemmonitor 08:53:29 INFO - Cleaning up... 08:53:29 INFO - Return code: 0 08:53:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:29 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 0x10df99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82b9da8c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de3dd30>, '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 0x10dc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de34b20>, '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.5RtI0ITUZZ/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.7lB343IyD8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 08:53:29 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 08:53:29 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 08:53:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5RtI0ITUZZ/Render', 08:53:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:29 INFO - 'HOME': '/Users/cltbld', 08:53:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:29 INFO - 'LOGNAME': 'cltbld', 08:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:29 INFO - 'MOZ_NO_REMOTE': '1', 08:53:29 INFO - 'NO_EM_RESTART': '1', 08:53:29 INFO - 'PAGER': '/bin/cat', 08:53:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:29 INFO - 'PWD': '/builds/slave/test', 08:53:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:29 INFO - 'SHELL': '/bin/bash', 08:53:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7lB343IyD8/Listeners', 08:53:29 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 08:53:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:29 INFO - 'USER': 'cltbld', 08:53:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:29 INFO - 'XPC_FLAGS': '0x0', 08:53:29 INFO - 'XPC_SERVICE_NAME': '0', 08:53:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:29 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53:31 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 08:53:31 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 08:53:31 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 08:53:31 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 08:53:31 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 08:53:31 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 08:53:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 INFO - Downloading docopt-0.6.1.tar.gz 08:53:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:32 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:32 INFO - Running setup.py install for blobuploader 08:53:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:33 INFO - Running setup.py install for requests 08:53:33 INFO - Running setup.py install for docopt 08:53:33 INFO - Successfully installed blobuploader requests docopt 08:53:33 INFO - Cleaning up... 08:53:33 INFO - Return code: 0 08:53:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:33 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')]} 08:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:33 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')]} 08:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:33 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 0x10df99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82b9da8c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de3dd30>, '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 0x10dc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de34b20>, '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.5RtI0ITUZZ/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.7lB343IyD8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 08:53:33 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 08:53:33 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 08:53:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5RtI0ITUZZ/Render', 08:53:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:33 INFO - 'HOME': '/Users/cltbld', 08:53:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:33 INFO - 'LOGNAME': 'cltbld', 08:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:33 INFO - 'MOZ_NO_REMOTE': '1', 08:53:33 INFO - 'NO_EM_RESTART': '1', 08:53:33 INFO - 'PAGER': '/bin/cat', 08:53:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:33 INFO - 'PWD': '/builds/slave/test', 08:53:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:33 INFO - 'SHELL': '/bin/bash', 08:53:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7lB343IyD8/Listeners', 08:53:33 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 08:53:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:33 INFO - 'USER': 'cltbld', 08:53:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:33 INFO - 'XPC_FLAGS': '0x0', 08:53:33 INFO - 'XPC_SERVICE_NAME': '0', 08:53:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:34 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-n2Rk0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:34 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-hBqUoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:34 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-lgVXh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:34 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-uTODfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:34 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-jrCkr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:34 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-2640nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:34 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-wssj4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:34 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-m0s00r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:34 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-r5QyuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:35 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-uqYEPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:35 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-8ErS21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:35 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-mUw8n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:35 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-LvIICK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:35 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-7XdA8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:35 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-1ofL8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:35 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-wpT9vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:35 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-oH9gtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:35 INFO - Running setup.py install for manifestparser 08:53:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:36 INFO - Running setup.py install for mozcrash 08:53:36 INFO - Running setup.py install for mozdebug 08:53:36 INFO - Running setup.py install for mozdevice 08:53:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:36 INFO - Running setup.py install for mozfile 08:53:36 INFO - Running setup.py install for mozhttpd 08:53:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:36 INFO - Running setup.py install for mozinfo 08:53:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:36 INFO - Running setup.py install for mozInstall 08:53:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Running setup.py install for mozleak 08:53:37 INFO - Running setup.py install for mozlog 08:53:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Running setup.py install for moznetwork 08:53:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Running setup.py install for mozprocess 08:53:37 INFO - Running setup.py install for mozprofile 08:53:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Running setup.py install for mozrunner 08:53:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:37 INFO - Running setup.py install for mozscreenshot 08:53:38 INFO - Running setup.py install for moztest 08:53:38 INFO - Running setup.py install for mozversion 08:53:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:38 INFO - Cleaning up... 08:53:38 INFO - Return code: 0 08:53:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:38 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 0x10df99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82b9da8c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de3dd30>, '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 0x10dc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de34b20>, '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.5RtI0ITUZZ/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.7lB343IyD8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 08:53:38 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 08:53:38 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 08:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5RtI0ITUZZ/Render', 08:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:38 INFO - 'HOME': '/Users/cltbld', 08:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:38 INFO - 'LOGNAME': 'cltbld', 08:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:38 INFO - 'MOZ_NO_REMOTE': '1', 08:53:38 INFO - 'NO_EM_RESTART': '1', 08:53:38 INFO - 'PAGER': '/bin/cat', 08:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:38 INFO - 'PWD': '/builds/slave/test', 08:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:38 INFO - 'SHELL': '/bin/bash', 08:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7lB343IyD8/Listeners', 08:53:38 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 08:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:38 INFO - 'USER': 'cltbld', 08:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:38 INFO - 'XPC_FLAGS': '0x0', 08:53:38 INFO - 'XPC_SERVICE_NAME': '0', 08:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:38 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-zTOfkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:38 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)) 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:38 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-jtugmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:38 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)) 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:38 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Se72XZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:38 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)) 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:38 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Iggab2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:39 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-McmpBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:39 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Xrvyi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:39 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-f6ptDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:39 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-KbClws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:39 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-bzTPVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:39 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-rTc7pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:39 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-FnAa4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:39 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-eaRhQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:39 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)) 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:39 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-pfeyun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:40 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)) 08:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-eOCkYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:40 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)) 08:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-20Ceqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:40 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)) 08:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-yJArWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:40 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)) 08:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-xgMyVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:40 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)) 08:53:40 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)) 08:53:40 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)) 08:53:40 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)) 08:53:40 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)) 08:53:40 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)) 08:53:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:42 INFO - Downloading blessings-1.6.tar.gz 08:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:42 INFO - Installing collected packages: blessings 08:53:42 INFO - Running setup.py install for blessings 08:53:43 INFO - Successfully installed blessings 08:53:43 INFO - Cleaning up... 08:53:43 INFO - Return code: 0 08:53:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:43 INFO - Reading from file tmpfile_stdout 08:53:43 INFO - Current package versions: 08:53:43 INFO - blessings == 1.6 08:53:43 INFO - blobuploader == 1.2.4 08:53:43 INFO - docopt == 0.6.1 08:53:43 INFO - manifestparser == 1.1 08:53:43 INFO - mozInstall == 1.12 08:53:43 INFO - mozcrash == 0.16 08:53:43 INFO - mozdebug == 0.1 08:53:43 INFO - mozdevice == 0.48 08:53:43 INFO - mozfile == 1.2 08:53:43 INFO - mozhttpd == 0.7 08:53:43 INFO - mozinfo == 0.9 08:53:43 INFO - mozleak == 0.1 08:53:43 INFO - mozlog == 3.1 08:53:43 INFO - moznetwork == 0.27 08:53:43 INFO - mozprocess == 0.22 08:53:43 INFO - mozprofile == 0.28 08:53:43 INFO - mozrunner == 6.11 08:53:43 INFO - mozscreenshot == 0.1 08:53:43 INFO - mozsystemmonitor == 0.0 08:53:43 INFO - moztest == 0.7 08:53:43 INFO - mozversion == 1.4 08:53:43 INFO - psutil == 3.1.1 08:53:43 INFO - requests == 1.2.3 08:53:43 INFO - wsgiref == 0.1.2 08:53:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:43 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 0x10df99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82b9da8c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de3dd30>, '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 0x10dc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de34b20>, '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.5RtI0ITUZZ/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.7lB343IyD8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 08:53:43 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 08:53:43 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 08:53:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5RtI0ITUZZ/Render', 08:53:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:43 INFO - 'HOME': '/Users/cltbld', 08:53:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:43 INFO - 'LOGNAME': 'cltbld', 08:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:43 INFO - 'MOZ_NO_REMOTE': '1', 08:53:43 INFO - 'NO_EM_RESTART': '1', 08:53:43 INFO - 'PAGER': '/bin/cat', 08:53:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:43 INFO - 'PWD': '/builds/slave/test', 08:53:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:43 INFO - 'SHELL': '/bin/bash', 08:53:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7lB343IyD8/Listeners', 08:53:43 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 08:53:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:43 INFO - 'USER': 'cltbld', 08:53:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:43 INFO - 'XPC_FLAGS': '0x0', 08:53:43 INFO - 'XPC_SERVICE_NAME': '0', 08:53:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 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)) 08:53:43 INFO - Cleaning up... 08:53:43 INFO - Return code: 0 08:53:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82b9da8c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de3dd30>, '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 0x10dc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de34b20>, '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.5RtI0ITUZZ/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.7lB343IyD8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 08:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:53:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5RtI0ITUZZ/Render', 08:53:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:43 INFO - 'HOME': '/Users/cltbld', 08:53:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:43 INFO - 'LOGNAME': 'cltbld', 08:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:43 INFO - 'MOZ_NO_REMOTE': '1', 08:53:43 INFO - 'NO_EM_RESTART': '1', 08:53:43 INFO - 'PAGER': '/bin/cat', 08:53:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:43 INFO - 'PWD': '/builds/slave/test', 08:53:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:43 INFO - 'SHELL': '/bin/bash', 08:53:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7lB343IyD8/Listeners', 08:53:43 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 08:53:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:43 INFO - 'USER': 'cltbld', 08:53:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:43 INFO - 'XPC_FLAGS': '0x0', 08:53:43 INFO - 'XPC_SERVICE_NAME': '0', 08:53:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:43 INFO - Downloading/unpacking jsonschema 08:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:46 INFO - Downloading/unpacking functools32 (from jsonschema) 08:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:46 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:46 INFO - warning: no files found matching '*.txt' 08:53:46 INFO - no previously-included directories found matching 'build' 08:53:46 INFO - no previously-included directories found matching 'dist' 08:53:46 INFO - no previously-included directories found matching '.git*' 08:53:46 INFO - Installing collected packages: jsonschema, functools32 08:53:46 INFO - Running setup.py install for functools32 08:53:47 INFO - warning: no files found matching '*.txt' 08:53:47 INFO - no previously-included directories found matching 'build' 08:53:47 INFO - no previously-included directories found matching 'dist' 08:53:47 INFO - no previously-included directories found matching '.git*' 08:53:47 INFO - Successfully installed jsonschema functools32 08:53:47 INFO - Cleaning up... 08:53:47 INFO - Return code: 0 08:53:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82b9da8c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de3dd30>, '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 0x10dc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de34b20>, '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.5RtI0ITUZZ/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.7lB343IyD8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 08:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:53:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5RtI0ITUZZ/Render', 08:53:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:47 INFO - 'HOME': '/Users/cltbld', 08:53:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:47 INFO - 'LOGNAME': 'cltbld', 08:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:47 INFO - 'MOZ_NO_REMOTE': '1', 08:53:47 INFO - 'NO_EM_RESTART': '1', 08:53:47 INFO - 'PAGER': '/bin/cat', 08:53:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:47 INFO - 'PWD': '/builds/slave/test', 08:53:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:47 INFO - 'SHELL': '/bin/bash', 08:53:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7lB343IyD8/Listeners', 08:53:47 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 08:53:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:47 INFO - 'USER': 'cltbld', 08:53:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:47 INFO - 'XPC_FLAGS': '0x0', 08:53:47 INFO - 'XPC_SERVICE_NAME': '0', 08:53:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:47 INFO - Downloading/unpacking flake8 08:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:53:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:53:49 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 08:53:49 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 08:53:49 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 08:53:49 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 08:53:49 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 08:53:49 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 08:53:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:53:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:53:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:53:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:53:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:53:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:53:50 INFO - no previously-included directories found matching 'docs/_build' 08:53:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:53:51 INFO - Running setup.py install for pep8 08:53:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:53:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:53:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:53:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:53:51 INFO - no previously-included directories found matching 'docs/_build' 08:53:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:53:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:53:51 INFO - Cleaning up... 08:53:51 INFO - Return code: 0 08:53:51 INFO - Running post-action listener: _resource_record_post_action 08:53:51 INFO - Running post-action listener: _start_resource_monitoring 08:53:51 INFO - Starting resource monitoring. 08:53:51 INFO - ##### 08:53:51 INFO - ##### Running install step. 08:53:51 INFO - ##### 08:53:51 INFO - Running pre-action listener: _resource_record_pre_action 08:53:51 INFO - Running main action method: install 08:53:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:51 INFO - Reading from file tmpfile_stdout 08:53:51 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:51 INFO - Reading from file tmpfile_stdout 08:53:51 INFO - Output received: 08:53:51 INFO - Usage: mozinstall [options] installer 08:53:51 INFO - Options: 08:53:51 INFO - -h, --help show this help message and exit 08:53:51 INFO - -d DEST, --destination=DEST 08:53:51 INFO - Directory to install application into. [default: 08:53:51 INFO - "/builds/slave/test"] 08:53:51 INFO - --app=APP Application being installed. [default: firefox] 08:53:51 INFO - mkdir: /builds/slave/test/build/application 08:53:51 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'] 08:53:51 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 08:54:25 INFO - Reading from file tmpfile_stdout 08:54:25 INFO - Output received: 08:54:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:54:25 INFO - Running post-action listener: _resource_record_post_action 08:54:25 INFO - ##### 08:54:25 INFO - ##### Running run-tests step. 08:54:25 INFO - ##### 08:54:25 INFO - Running pre-action listener: _resource_record_pre_action 08:54:25 INFO - Running main action method: run_tests 08:54:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:54:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:54:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:54:25 INFO - 2016-03-02 08:54:25.160 screenresolution[1650:7595] starting screenresolution argv=screenresolution get 08:54:25 INFO - 2016-03-02 08:54:25.162 screenresolution[1650:7595] Display 0: 1600x1200x32@60 08:54:25 INFO - 2016-03-02 08:54:25.168 screenresolution[1651:7598] starting screenresolution argv=screenresolution list 08:54:25 INFO - Available Modes on Display 0 08:54:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:54:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:54:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:54:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:54:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:54:25 INFO - Intel Iris: 08:54:25 INFO - Chipset Model: Intel Iris 08:54:25 INFO - Type: GPU 08:54:25 INFO - Bus: Built-In 08:54:25 INFO - VRAM (Dynamic, Max): 1536 MB 08:54:25 INFO - Vendor: Intel (0x8086) 08:54:25 INFO - Device ID: 0x0a2e 08:54:25 INFO - Revision ID: 0x0009 08:54:25 INFO - Displays: 08:54:25 INFO - Display: 08:54:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:54:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:54:25 INFO - Display Serial Number: 1600x1200 60 08:54:25 INFO - Main Display: Yes 08:54:25 INFO - Mirror: Off 08:54:25 INFO - Online: Yes 08:54:25 INFO - Rotation: Supported 08:54:25 INFO - Return code: 0 08:54:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:25 INFO - Python 2.7.3 08:54:25 INFO - Return code: 0 08:54:25 INFO - grabbing minidump binary from tooltool 08:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:25 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 0x10de3dd30>, '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 0x10dc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de34b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:25 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 08:54:25 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 08:54:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:25 INFO - Return code: 0 08:54:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:54:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:54:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:54:26 INFO - Return code: 0 08:54:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:54:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0124 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:54:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5RtI0ITUZZ/Render', 08:54:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:26 INFO - 'HOME': '/Users/cltbld', 08:54:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:26 INFO - 'LOGNAME': 'cltbld', 08:54:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:26 INFO - 'MOZ_NO_REMOTE': '1', 08:54:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:26 INFO - 'NO_EM_RESTART': '1', 08:54:26 INFO - 'PAGER': '/bin/cat', 08:54:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:26 INFO - 'PWD': '/builds/slave/test', 08:54:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:26 INFO - 'SHELL': '/bin/bash', 08:54:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7lB343IyD8/Listeners', 08:54:26 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 08:54:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:26 INFO - 'USER': 'cltbld', 08:54:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:26 INFO - 'XPC_FLAGS': '0x0', 08:54:26 INFO - 'XPC_SERVICE_NAME': '0', 08:54:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:54:26 INFO - mozversion application_buildid: 20160302053632 08:54:26 INFO - mozversion application_changeset: 1db864e863ed710a3e51ef795b32e070fd9cc145 08:54:26 INFO - mozversion application_display_name: Nightly 08:54:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:26 INFO - mozversion application_name: Firefox 08:54:26 INFO - mozversion application_remotingname: firefox 08:54:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:54:26 INFO - mozversion application_vendor: Mozilla 08:54:26 INFO - mozversion application_version: 47.0a1 08:54:26 INFO - mozversion platform_buildid: 20160302053632 08:54:26 INFO - mozversion platform_changeset: 1db864e863ed710a3e51ef795b32e070fd9cc145 08:54:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:54:26 INFO - mozversion platform_version: 47.0a1 08:54:26 INFO - using testdate: 1456937666 08:54:26 INFO - actual date: 1456937666 08:54:26 INFO - starting webserver on 'localhost:49281' 08:54:26 INFO - SUITE-START | Running 2 tests 08:54:26 INFO - TEST-START | dromaeo_css 08:54:26 INFO - operating with platform_type : mac_ 08:54:26 INFO - Initialising browser for dromaeo_css test... 08:54:26 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpeVjMU6/profile http://localhost:49281/getInfo.html) 08:54:29 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 08:54:29 INFO - PROCESS | 1669 | colorDepth:24 08:54:29 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 08:54:29 INFO - PROCESS | 1669 | __metrics 08:54:30 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:54:30 INFO - TEST-INFO | 1669: exit 0 08:54:30 INFO - Browser initialized. 08:54:30 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:30 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpeVjMU6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:42 INFO - PROCESS | 1673 | RSS: Main: 254038016 08:54:42 INFO - PROCESS | 1673 | 08:55:32 INFO - PROCESS | 1673 | 1456937732318 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] 08:57:42 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 08:57:43 INFO - PROCESS | 1673 | RSS: Main: 270573568 08:57:43 INFO - PROCESS | 1673 | 09:00:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 09:00:46 INFO - PROCESS | 1673 | RSS: Main: 281423872 09:00:46 INFO - PROCESS | 1673 | 09:03:48 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 09:03:48 INFO - PROCESS | 1673 | RSS: Main: 282128384 09:03:48 INFO - PROCESS | 1673 | 09:06:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 09:06:51 INFO - PROCESS | 1673 | RSS: Main: 284999680 09:06:51 INFO - PROCESS | 1673 | 09:09:53 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 09:09:54 INFO - PROCESS | 1673 | RSS: Main: 287940608 09:09:54 INFO - PROCESS | 1673 | 09:12:56 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 09:12:56 INFO - PROCESS | 1673 | RSS: Main: 287825920 09:12:56 INFO - PROCESS | 1673 | 09:12:56 INFO - PROCESS | 1673 | __start_tp_report 09:12:56 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 09:12:56 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 09:12:56 INFO - PROCESS | 1673 | |i|pagename|runs| 09:12:56 INFO - PROCESS | 1673 | |0;dojo.html;2822.7177282271778;3484.2508860594967;3520.8767693130744;3541.4510750833615;3562.251927095309;5655.0386434306165;5660.518855897254;5669.291338582682;5704.743286552105;5707.4577915098;5494.587905907053;5630.324361076667;5705.115707065401;5709.571782116337;5826.504747096491;5089.134847075988;5120.743962801864;5154.639175257734;5183.3779946406485;5200.869978250536;5154.175331946889;5163.922541161885;5190.2474141249495;5212.609054320922;5213.973930130344;5049;5055.0900837848985;5072.492750724935;5113.156329205676;5113.744312784346;4362.585554372329;4965.280034394992;5099.36257967754;5112.309838171836;5146.253793200002;4034.5965403459713;4719.221328480797;4992.6005919526715;5042.495750424965;5082.390113186404;4135.7932103395015;5542.168674698787;5620.1288800236025;5624.0439125348785;5653.840962602698;6162.969185154046;6197.907031394533;6201.937980620181;6213.13016177731;6219.1915051043525;6109.5112391008615;6151.661658608775;6179.6292222466345;6210.099535567318;6223.68881555925;5799.130130480377;5813.6802475863815;5821.097729851922;5825.912611310791;5831.416858314177;6220.626762394271;6234.251889773256;6242.75028998844;6248.625082495065;6310.368963103653;5972.611780234271;6081.817545473643;6108.9795837225665;6130.203073600493;6135.84660383494;5674.4892959633835;6049;6172.444479996821;6196.411340922605;6204.81385558434;6105.2799457750825;6126.090206827809;6130.122981477994;6148.815535533941;6163.137160797492;6076.453119219292;6097.706167156134;6133.233345831771;6172.722227499684;6179.104029915727;4104.035551645361;4810.903781924412;4853.223484242504;4860.975695121501;4867.440244371872;4357.9782101089295;4398.362237475548;4410.889727756832;4434.711743736647;4469.262571675637;5587.636803607753;5665.688387138664;5703.9429605704245;5714.7428365723645;5750.971245143747;6202.596831206048;6204.069389591597;6206.255249370104;6223.813285601439;6232.719527621268;4642.442906851199;5187.896242075138;5520.227168196456;5669.319681638147;5719.170720245541;5249.553787927993;5295.814646487432;5302.469753024667;5303.973480132575;5350.892982140335;6255;6261.217347831521;6266;6266.248050234001;6284;5182.222666600041;6096.254562767794;6131.223750760645;6192.535559832941;6220.377962203744;5806.664467172658;5825.825225243249;6189.319174890668;6256.718447669957;6273.341299163522;6072.423119803611;6085.482733967662;6113;6128.111423843607;6140.4473597376455;5418.593605479526;6051.062085376773;6066.241719785027;6068.544859135494;6124.295705993868;5986.2517185351835;6008.699565021644;6075.210222671025;6110.938890611037;6135.631862088289;5748.6838223898085;6039.396060394101;6096.29892562361;6103.267607887082;6113.419225173601;5671.858203544944;5817.76728930838;5855.970720146372;5988.940110598838;6044.15381846533;6040.244969378828;6046.697665116639;6080.118382834553;6101.084837274444;6141.508679305555;5984.790532331522;5990.880182396415;5998.670073145844;6000.129981152621;6003.249593800775 09:12:56 INFO - PROCESS | 1673 | |1;ext.html;429.1459994610724;476.4401827852275;476.48539577256565;563.7913971830422;598.1118039711031;37463.43804842929;38073.619263807355;38148.80925595368;38181.61818381815;38235.61764382362;39153.80423097888;39386;39408.817735467914;39582.01044973877;39697.40453893186;9355.672551460717;9623.759406014871;9633.518324083803;9635.325527213097;9637.132658060773;9546.809063818719;9682.903170968306;9689.515524223796;9701.320907536476;9706.70879873605;9631.71104866855;9692.369995950276;9742.51287435629;9744;9752.36609620376;9576.946535881047;9683.757906052335;9686.176674982635;9691.709248722585;9770.316077874551;9497.762555936088;9641.084097010773;9665.323427360088;9677;9685.661001864972;37941;38469.61530384716;38503.807480962416;38648;38731;3154.2587491939375;3171.1913462067255;3297;3561.786292822439;4026.4362989181536;27474.862625686943;27653.446931061466;27788.444231115467;27854;28485;2745.217612980311;2748.1480740970364;2769.9030533931214;2863.21261653045;2914.941701165965;354858.99999999744;384302;406825;411197;411631;63113.36886631167;63412;63641;63704.04443933345;63745;71652;72130.9180362295;72862.27137728555;73184.26815731882;73490.26509734834;16165.59586010359;16211.675766484841;16246.837531624533;16407;16436.931599445998;12411.875881241253;12506.499740010298;12556;12566.434510447052;12607.054470914718;21114.366569002956;21170.894145529175;21244.787552124282;21278.936053197278;21289.254876079263;9025.23285520725;9268.212201962908;9291.907080929104;9321.44071355721;9333;886.9157430044136;1009.2329829329763;1051.2063392138887;1058.8035519862506;1119.339589642115;29380.559291610643;29672.1098367045;29674.66069903237;30046.69953300439;30702.771889124186;854.5086575219274;1039.0856046678873;1073.2380010192694;1086.4079076903106;1201.567435723139;11923.926846583849;13801.51694690681;14407.855921440652;14524.709505809824;14707.852921470649;530791;531787;537997;539097;539520;58020.41979580234;58301.4169858296;58755.706221468616;58989.70505147533;59252.70373648104;1343.1135450602555;1374.202962281894;1413.4699487692114;1417.397606017459;1417.4188582681256;25173.87413062923;26275.4744905097;27268.590971135847;28814.423711525233;29333.41333173367;43917.902052448946;46534.30198546957;50501.989960199855;51371;51764.48235517597;491030;496611;499522;503312.41718955856;505140;33331.83334083411;33388.99833005014;33572.49641255432;33631.831840841616;34133.65866341305;44945.32582011338;45041.09917801691;45436.77281613571;45840.624781256614;46330.84172895704;32075.839620801748;37131.443028355134;37396.62603373932;37434.87695369143;37913.81043094767;30456.695433045385;36606.267874642894;36742.44886326761;37076.62923370732;37188;29602;36185;36747.89756307315;37058.444123337635;37925;31998;32236.83881580577;32759;38700.6129938697;39931.40102898517;29937.850310749178;30548.694513054586;30966.845165774026;31335.373292534478;31389.744410223335 09:12:56 INFO - PROCESS | 1673 | |2;jquery.html;305.58135354564246;351.10468305820166;358.19048949374405;358.9892303230904;364.18967796652436;19122;19137.42587722367;20441;20462.693059604117;20496.282630107948;18852.151653175606;19235.807641923577;19353.032348382596;19418.02909854509;19440.805591944078;5383.300170977777;5644.604877658545;5684.062129748587;5686.886262274752;5706.058500347438;4110.280700877334;5626.521745651625;5937.367224013409;6188.47397971173;6202.4727898128485;6139.048447490623;6156.846078848042;6158.6612736299485;6161.599496032766;6167.136600875881;5897.793577224798;6176.382361763787;6177;6178.598391104564;6186.783462578811;4465.173942820588;5209.661372010845;5233.371995360543;5326.627136100475;5351.331083614548;24028;24476.265712028668;24791.752082479125;24807.875960620262;24845.751542484526;2068.8758674479577;2105.884176370299;2312.90748370065;2318.6637937498967;2508.83692559983;14275.21486318252;14462.78305825403;14551.636209094751;14661.92669036648;14986.925065374604;1687.9324827006906;1690.1464760296094;1741.7126174181244;1767.1252729898654;1767.8939263644222;107004.39493407604;108338;109980.25095254225;110396.89603103946;111803;8364.247217750431;8531.616077276538;10140.391576505433;10549.20880933933;10608.363498190134;12491.188072775241;12546.184498007782;12556.246625202517;12655.493780248871;12681.492740290285;6815.182178138655;8146;8292.17078292178;8387.538685372241;8472.068072512018;7027.754028609076;7372.557646541225;8562.015368232609;8655.567221638892;8765.991910930197;5906.616069955439;6062.575619706578;6144.109104179958;6144.477719393902;6234.127222188898;1490.6646004649085;1676.5640933357415;1726.2231995602028;1799.379214171109;1810.248746770102;875.9956200218958;879.8064425826308;882.8013696918142;933.178802653674;961.5192403798101;16947.40684076076;19195.61608767817;19754.60490790205;19888.801111988694;19996.60006799856;926.7683079230193;948.8339540580508;981.16600889245;1008.6520150548049;1041.109851077318;11067.778644427066;11301.547938082385;11323;11357.943210283896;11358.148138889615;574675;581989;586401;650713;662658;110006;117547.88582399575;120064;120875;127926;455.8609624064626;478.66732620828884;479.0443066083117;480.06627110270887;1007.9294449388473;9772.804543909224;17395.04327262013;17674;19304.71042934329;19318.8068119317;34575;51680.707982300744;51800.74099629478;51860.96278074493;53414;67877.9273243607;70203;70730;71068.64465677639;71341.57316853738;7829.608519573884;7906.5651389174145;7926.762197134095;7992.640331185227;8177.754667359989;9666.56500457467;12776.6805829855;12967.740645187232;13049.34753262352;13161.605151845077;11040.834387484354;11192.832107518556;11309.886901130883;11529.596464123715;11789.292642441482;8776.297896168164;11128.721781955192;11345.716357091138;11415.486303116546;11532.59635912739;11274.549018039186;11511.827322590001;11642.53429862796;11665.00847427978;11797.76404471923;7612.200718924433;8076.798080048045;8079.757607271791;8380.916190838014;8399.790005249917;9746.463944482837;10852.403117828595;10902.618408355669;11420.371879546372;11641.53433862636 09:12:56 INFO - PROCESS | 1673 | |3;mootools.html;1311.4360824845317;1544.3050627217756;1725.404735366299;1726.3094762095152;1847.0303090877287;7108.964455177716;8147.796305092375;8373.12082231366;8437.746867593967;8646.783830404234;8423.536705481196;8518.105598912118;8569.614367353468;8585.699500517483;8631.784205394868;2270.546850015991;2396.484755777512;2405.290439320405;2410.1323523531514;2419.903203871843;2167.7073595064703;2382.8570285782907;2417.407735104893;2436.2204094689705;2446.706395232575;2400.0879665726998;2414.6015907375263;2420.4190994161363;2431.2098567965395;2440.3289095498703;2384.6899903012672;2403.170906037414;2409.566278069938;2415.867127307997;2420.455397535558;2377.2511658827416;2408.4099395648004;2412.433078226615;2415.347856078849;2417.1177520205174;7653.693852245903;8429.662813487454;8525.19010693983;8573.914260857375;8676.305895528343;4470.307102399133;5160.122779127557;5298.36419629643;5333.653312534673;5346.438623944468;3510.5611798525183;3517.6482351764876;3549.2014296783277;3581.1047238190454;3627.093226693327;967.617790972569;982.6167794560128;1002.7693630465034;1615.878809089323;1658.9502314930571;11441.313521188755;11527.020203282731;11567.710807229803;11570.826437603442;11590.594329198522;4515.322701594787;4577;4632.907341853144;4655.3249778782565;4669.859904202879;8946.552672366355;9048.185663290336;9054.637814487478;9073.001969783318;9075.047120052299;5177.990291893045;5198.012377648235;5208.192730126836;5219.08665983459;5228.7908483660985;4325.610695037399;4646.512116227815;4736.573708366263;4762.190427627312;4841.491643377465;3620.7827530348263;3691.501647277637;3694.852205911787;3727.8881633550495;3747.3254814133174;1173.565780661161;1179.7168679516853;1182.8403165572709;1183.207251141737;1185.3836005277208;1324.9271290078946;1332.4203971272527;1352.1008529328083;1363.0526783885105;1368.0902200036865;7876.606169691492;7947.721829735931;8056.234657707509;8062.072861620872;8070;492.3746841511261;498.4990084964587;504.8990201959623;506.27349753104414;506.47832732285804;6036.3360030396625;6076;6090.665013424305;6164.599301045418;6164.660943648053;9396.765080873032;10235.976402359704;10264;10278.486075696186;10378.532966016548;9068.773280667903;10070.69787906364;10143.64497242593;10207.693769186937;10223.897761022294;7846.254605812439;7897.447178697436;7911.129775724666;7970.840583188304;8041.276285134366;7730.304272615492;7736.303732664087;7774.727884524014;7821.022372203474;7915.485493442908;9185.632574696938;9425;9463.905360946303;9524.23806095497;9614.519274036411;9490.715278541655;9626.085521875411;9757.268204884804;9764.316497845082;9916.851247231441;6668.699908504032;7007.509474336747;7230.602316872622;7327.560346379234;7415.147258065176;6575.473962083118;6684.498662600422;7958.801029974297;8010.078840933367;8037.879431808645;6971.163460384786;7065.6467176639935;7067.787966361017;7171.318724721144;7200;6954.860902782018;6960.547564408297;6973.965130174317;7073.71705131789;7088.822779430556;7453.217412171643;7513.812154696177;7517.736879209201;7580.620968951641;7591.240875912365;6862.210845752802;6868.484863635147;6880.311968803079;6894.448444124559;6906.896396553955;6894;6948.062011628365;7010.719571217094;7010.754623588354;7013.193482749549 09:12:56 INFO - PROCESS | 1673 | |4;prototype.html;315.4511150597959;321.1617677860783;327.62071678234634;328.34331337325347;330.0527486114851;5896.675682837442;6760.66196690166;6800.4559635229125;6832.2142953560415;6861.416779573736;6665.366790154928;6798.252192258848;6802.013708012335;6830.316968303179;6844.726210951556;4700.670953033289;4732.1482133216;4938.456769755342;4940.209566469365;4980.02889436561;4935.087008903346;4950.084234416627;4950.603951683856;4951.034548263072;4962.42932062812;4870.245112007645;4875.926861097087;4879.268109783526;4925.876853078666;4927.457979622239;4905.705657660534;4940.90118197634;4947.703137811743;4949.851504454872;4959.429665588467;4244.596763307481;4256.063665993476;4256.851010214658;4259.424977628011;4263.637590804754;6298.905516417258;6572.882609956271;6577.079208910708;6590.967045164792;6651.368120028589;5795.710214489301;5806.767729290823;5818.301803783531;5831;5865.237519122529;7368.410527157815;7393.2606739326175;7398;7401.666924988334;7413.073365829271;4638.512956139591;4655.976720116411;4660.324252983332;4661.7902194400995;4691.3432119503295;7396.741114060982;7690.115636701739;7728.729494467667;7729.227077292282;7758.728444504415;4530.954690453119;4599.494055653875;4691.272852707836;4693.319468677023;4700.529947005272;4769.689970151929;4769.902922327884;4779.761011949388;4796.712197268175;4801.375821143229;5741.19623252745;5776.537876969916;5801.013827649225;5828.271466066742;5842.766289348378;7375.704971801068;7377.483576149725;7382.261773822682;7387.1135463744695;7413.777586672409;1637.2223193982763;1666.7416550434702;1672.1304921440783;1672.5902153972354;1673.9414120505967;787.649495974286;1013.9391636501833;1053.9420331881668;1068.5672302717412;1069.3049517813329;5607.8503906699025;6472.870542589216;6779.72881084751;6797.966010169917;6853.26497059104;7552.848943021108;7598.088229412506;7598.20218877021;7606.201348858401;7628.504147230412;5660.349059858087;6540.803775886731;6694.933050669431;6810.863782724317;6829.453643708492;3989.7207195496617;4000.0199951012187;4024.75851448914;4034.838606455709;4034.8789536313957;7899.605019748989;7916.050073991158;7922.049354077432;7923.801904952422;7927.0883848357025;7830.62963981301;7834.1774113718375;7849.3328067114935;7858;7858.5677787722225;7848.568328741974;7870.72452464161;7899.842003159904;7914;8164.30603398694;7568.318851303409;7755.379569634529;7769.456138070507;7776.222377762178;7787.805304867424;7591.620418978919;7626.275503827128;7638.045244344457;7657.731979380695;7664.73173438927;8059.717909873127;8064.55644939534;8070.47541909774;8072.354211663171;8116.959415202886;4558.772061396983;4683.484816670231;4712.081144176853;4749.7625118743235;4750.477447480705;7388.926110738824;7479.065116860393;7610.048743907012;7658.4639075264195;7734.7679569613;7370.852582948418;7434.702611895464;7442.144153422426;7445.553266804009;7461.328480436787;5974;7401.925980740339;7432.888506672296;7437.405007599271;7451.254874512505;6996.685149168198;7234.529755565872;7245.7826265212125;7252.238514956065;7255.129384473897;7431.8142046449275;7433.145188303414;7434.36807871337;7448.180700123091;7457.6271186441545;7251.347378735939;7254.274572542915;7254.782356529313;7266.636668166676;7289.635518224173 09:12:56 INFO - PROCESS | 1673 | |5;yui.html;650.8145178624093;680.1769858471249;716.6237725194276;726.6621021225131;743.6988019851958;14665.193414362206;14851.925740371284;14896.25518724065;14942.178180200084;15030.624234394145;13675.179489230653;13730.65673358164;13741.175529468239;13744.381502832372;13791.379387927542;680.0309558878578;835.8787975743513;836.1053672570337;844.3287586368851;859.9613017414231;838.4633834346023;839.0686338164633;843.755310959824;846.1580727176437;852.6631980367752;865.5974971638187;885.2608072259671;895.5656506594297;896.6906417286059;898.4743924803964;864.1358641358642;879.4898958603994;889.168627333442;892.6117139044504;893.8793262909489;660.6762686283735;663.4625952978104;670.5272782688193;672.5695554844904;673.8012286375531;14157.150570965672;14214.50249241282;14235.928820355935;14270.215138167398;14382.208978506282;12252;12306.81539776904;12370.381480925918;12519.3740312984;12587.74824503514;9271.119243671841;9467.147956683863;9719.368241064309;9848.409095454295;9869.950650246774;2877.8129421587737;2890.3930174663346;3432.845521951518;3444.6555344465605;3516.841742121611;59848;79498.20501794966;79641.60179199067;82246.17753822445;82453;9138.54307284633;9184.724458266262;9187.070715149894;9408.294377921684;9469.337146399823;20809.37571872846;20950.790492095188;20965.37103886886;21016;21034.158633654788;7373.926260737431;7394.482386232912;7397.445191610651;7408.518446300973;7600.201978792147;4018.598140185958;4077.408775727503;4083.612056854594;4094.5086589609436;4094.856680016245;3331.6002079750583;3344.73242140633;3369.292448585775;3375.3080618473155;3376.544166537486;610.0696437932189;619.8853212155766;621.6611946489174;626.2735227136591;626.6240255846546;502.412177752031;554.6006875049958;576.2911618709012;586.7652938824505;608.0969759906535;7936.4841285317425;7965.56189409588;8012.238837310446;8140.389470789714;8204.671813127408;567.2257368691706;574.2420005592578;577.4802677590202;588.802751078385;615.1050221927086;3759.5112635357777;3807.923841523154;3823.2735780201674;3849.1147036181833;3904.141088960424;78961;79463.20536794674;81100;81724.59137704273;82555;74645;75235.62382188163;75634.48731025349;76058;76735;63659.36340636627;64609.67695161588;67105;67612.32387676061;67782.08488206333;7675.961620191863;7708.884366734392;7759.61201939912;7782.143964164051;7784;47341.289880652505;49158.508414916825;49300.013999719085;49453.50546494489;49959.75020124876;63528.047079294774;64611;64696.67651661712;64911;65605;9756.902430975599;9960.402375857471;10014.849777253492;10029.398236105566;10340.224483163944;10044.849327260243;10257.487125643538;10310.845337319795;10387.324823886423;10454.215933805148;9712.75718107053;9806.362586431858;9878;9997.350172238781;10053.396796192252;7679.769606911802;9697.466639334903;10218.437985910548;10260.948695256477;10670;9812.65655702047;9843.064908833936;9849.212063034796;10025.899741002788;10133.986601339808;8476.49141051539;8606.311495080503;8639;8678.956605216934;8750.91249087501;8645.351598630003;8665.480071195749;8747.16901894319;9386.436813791195;9513.76215594588 09:12:56 INFO - PROCESS | 1673 | __end_tp_report 09:12:56 INFO - PROCESS | 1673 | __start_cc_report 09:12:56 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,340 09:12:56 INFO - PROCESS | 1673 | __end_cc_report 09:12:56 INFO - PROCESS | 1673 | __startTimestamp1456938776765__endTimestamp 09:12:56 INFO - PROCESS | 1673 | 09:12:56 INFO - PROCESS | 1673 | ------- Summary: start ------- 09:12:56 INFO - PROCESS | 1673 | Number of tests: 6 09:12:56 INFO - PROCESS | 1673 | 09:12:56 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5639.11 Median:5831.42 stddev:675.52 (11.6%) stddev-sans-first:640.44 09:12:56 INFO - PROCESS | 1673 | Values: 2822.7 3484.3 3520.9 3541.5 3562.3 5655.0 5660.5 5669.3 5704.7 5707.5 5494.6 5630.3 5705.1 5709.6 5826.5 5089.1 5120.7 5154.6 5183.4 5200.9 5154.2 5163.9 5190.2 5212.6 5214.0 5049.0 5055.1 5072.5 5113.2 5113.7 4362.6 4965.3 5099.4 5112.3 5146.3 4034.6 4719.2 4992.6 5042.5 5082.4 4135.8 5542.2 5620.1 5624.0 5653.8 6163.0 6197.9 6201.9 6213.1 6219.2 6109.5 6151.7 6179.6 6210.1 6223.7 5799.1 5813.7 5821.1 5825.9 5831.4 6220.6 6234.3 6242.8 6248.6 6310.4 5972.6 6081.8 6109.0 6130.2 6135.8 5674.5 6049.0 6172.4 6196.4 6204.8 6105.3 6126.1 6130.1 6148.8 6163.1 6076.5 6097.7 6133.2 6172.7 6179.1 4104.0 4810.9 4853.2 4861.0 4867.4 4358.0 4398.4 4410.9 4434.7 4469.3 5587.6 5665.7 5703.9 5714.7 5751.0 6202.6 6204.1 6206.3 6223.8 6232.7 4642.4 5187.9 5520.2 5669.3 5719.2 5249.6 5295.8 5302.5 5304.0 5350.9 6255.0 6261.2 6266.0 6266.2 6284.0 5182.2 6096.3 6131.2 6192.5 6220.4 5806.7 5825.8 6189.3 6256.7 6273.3 6072.4 6085.5 6113.0 6128.1 6140.4 5418.6 6051.1 6066.2 6068.5 6124.3 5986.3 6008.7 6075.2 6110.9 6135.6 5748.7 6039.4 6096.3 6103.3 6113.4 5671.9 5817.8 5856.0 5988.9 6044.2 6040.2 6046.7 6080.1 6101.1 6141.5 5984.8 5990.9 5998.7 6000.1 6003.2 09:12:56 INFO - PROCESS | 1673 | 09:12:56 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:62713.89 Median:38208.62 stddev:127633.39 (334.0%) stddev-sans-first:127905.76 09:12:56 INFO - PROCESS | 1673 | Values: 429.1 476.4 476.5 563.8 598.1 37463.4 38073.6 38148.8 38181.6 38235.6 39153.8 39386.0 39408.8 39582.0 39697.4 9355.7 9623.8 9633.5 9635.3 9637.1 9546.8 9682.9 9689.5 9701.3 9706.7 9631.7 9692.4 9742.5 9744.0 9752.4 9576.9 9683.8 9686.2 9691.7 9770.3 9497.8 9641.1 9665.3 9677.0 9685.7 37941.0 38469.6 38503.8 38648.0 38731.0 3154.3 3171.2 3297.0 3561.8 4026.4 27474.9 27653.4 27788.4 27854.0 28485.0 2745.2 2748.1 2769.9 2863.2 2914.9 354859.0 384302.0 406825.0 411197.0 411631.0 63113.4 63412.0 63641.0 63704.0 63745.0 71652.0 72130.9 72862.3 73184.3 73490.3 16165.6 16211.7 16246.8 16407.0 16436.9 12411.9 12506.5 12556.0 12566.4 12607.1 21114.4 21170.9 21244.8 21278.9 21289.3 9025.2 9268.2 9291.9 9321.4 9333.0 886.9 1009.2 1051.2 1058.8 1119.3 29380.6 29672.1 29674.7 30046.7 30702.8 854.5 1039.1 1073.2 1086.4 1201.6 11923.9 13801.5 14407.9 14524.7 14707.9 530791.0 531787.0 537997.0 539097.0 539520.0 58020.4 58301.4 58755.7 58989.7 59252.7 1343.1 1374.2 1413.5 1417.4 1417.4 25173.9 26275.5 27268.6 28814.4 29333.4 43917.9 46534.3 50502.0 51371.0 51764.5 491030.0 496611.0 499522.0 503312.4 505140.0 33331.8 33389.0 33572.5 33631.8 34133.7 44945.3 45041.1 45436.8 45840.6 46330.8 32075.8 37131.4 37396.6 37434.9 37913.8 30456.7 36606.3 36742.4 37076.6 37188.0 29602.0 36185.0 36747.9 37058.4 37925.0 31998.0 32236.8 32759.0 38700.6 39931.4 29937.9 30548.7 30966.8 31335.4 31389.7 09:12:56 INFO - PROCESS | 1673 | 09:12:56 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:34420.98 Median:13677.29 stddev:101633.06 (743.1%) stddev-sans-first:101885.89 09:12:56 INFO - PROCESS | 1673 | Values: 305.6 351.1 358.2 359.0 364.2 19122.0 19137.4 20441.0 20462.7 20496.3 18852.2 19235.8 19353.0 19418.0 19440.8 5383.3 5644.6 5684.1 5686.9 5706.1 4110.3 5626.5 5937.4 6188.5 6202.5 6139.0 6156.8 6158.7 6161.6 6167.1 5897.8 6176.4 6177.0 6178.6 6186.8 4465.2 5209.7 5233.4 5326.6 5351.3 24028.0 24476.3 24791.8 24807.9 24845.8 2068.9 2105.9 2312.9 2318.7 2508.8 14275.2 14462.8 14551.6 14661.9 14986.9 1687.9 1690.1 1741.7 1767.1 1767.9 107004.4 108338.0 109980.3 110396.9 111803.0 8364.2 8531.6 10140.4 10549.2 10608.4 12491.2 12546.2 12556.2 12655.5 12681.5 6815.2 8146.0 8292.2 8387.5 8472.1 7027.8 7372.6 8562.0 8655.6 8766.0 5906.6 6062.6 6144.1 6144.5 6234.1 1490.7 1676.6 1726.2 1799.4 1810.2 876.0 879.8 882.8 933.2 961.5 16947.4 19195.6 19754.6 19888.8 19996.6 926.8 948.8 981.2 1008.7 1041.1 11067.8 11301.5 11323.0 11357.9 11358.1 574675.0 581989.0 586401.0 650713.0 662658.0 110006.0 117547.9 120064.0 120875.0 127926.0 455.9 478.7 479.0 480.1 1007.9 9772.8 17395.0 17674.0 19304.7 19318.8 34575.0 51680.7 51800.7 51861.0 53414.0 67877.9 70203.0 70730.0 71068.6 71341.6 7829.6 7906.6 7926.8 7992.6 8177.8 9666.6 12776.7 12967.7 13049.3 13161.6 11040.8 11192.8 11309.9 11529.6 11789.3 8776.3 11128.7 11345.7 11415.5 11532.6 11274.5 11511.8 11642.5 11665.0 11797.8 7612.2 8076.8 8079.8 8380.9 8399.8 9746.5 10852.4 10902.6 11420.4 11641.5 09:12:56 INFO - PROCESS | 1673 | 09:12:56 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:5819.70 Median:5691.39 stddev:3054.20 (53.7%) stddev-sans-first:3043.96 09:12:56 INFO - PROCESS | 1673 | Values: 1311.4 1544.3 1725.4 1726.3 1847.0 7109.0 8147.8 8373.1 8437.7 8646.8 8423.5 8518.1 8569.6 8585.7 8631.8 2270.5 2396.5 2405.3 2410.1 2419.9 2167.7 2382.9 2417.4 2436.2 2446.7 2400.1 2414.6 2420.4 2431.2 2440.3 2384.7 2403.2 2409.6 2415.9 2420.5 2377.3 2408.4 2412.4 2415.3 2417.1 7653.7 8429.7 8525.2 8573.9 8676.3 4470.3 5160.1 5298.4 5333.7 5346.4 3510.6 3517.6 3549.2 3581.1 3627.1 967.6 982.6 1002.8 1615.9 1659.0 11441.3 11527.0 11567.7 11570.8 11590.6 4515.3 4577.0 4632.9 4655.3 4669.9 8946.6 9048.2 9054.6 9073.0 9075.0 5178.0 5198.0 5208.2 5219.1 5228.8 4325.6 4646.5 4736.6 4762.2 4841.5 3620.8 3691.5 3694.9 3727.9 3747.3 1173.6 1179.7 1182.8 1183.2 1185.4 1324.9 1332.4 1352.1 1363.1 1368.1 7876.6 7947.7 8056.2 8062.1 8070.0 492.4 498.5 504.9 506.3 506.5 6036.3 6076.0 6090.7 6164.6 6164.7 9396.8 10236.0 10264.0 10278.5 10378.5 9068.8 10070.7 10143.6 10207.7 10223.9 7846.3 7897.4 7911.1 7970.8 8041.3 7730.3 7736.3 7774.7 7821.0 7915.5 9185.6 9425.0 9463.9 9524.2 9614.5 9490.7 9626.1 9757.3 9764.3 9916.9 6668.7 7007.5 7230.6 7327.6 7415.1 6575.5 6684.5 7958.8 8010.1 8037.9 6971.2 7065.6 7067.8 7171.3 7200.0 6954.9 6960.5 6974.0 7073.7 7088.8 7453.2 7513.8 7517.7 7580.6 7591.2 6862.2 6868.5 6880.3 6894.4 6906.9 6894.0 6948.1 7010.7 7010.8 7013.2 09:12:56 INFO - PROCESS | 1673 | 09:12:56 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:5986.25 Median:6799.35 stddev:1966.20 (28.9%) stddev-sans-first:1925.09 09:12:56 INFO - PROCESS | 1673 | Values: 315.5 321.2 327.6 328.3 330.1 5896.7 6760.7 6800.5 6832.2 6861.4 6665.4 6798.3 6802.0 6830.3 6844.7 4700.7 4732.1 4938.5 4940.2 4980.0 4935.1 4950.1 4950.6 4951.0 4962.4 4870.2 4875.9 4879.3 4925.9 4927.5 4905.7 4940.9 4947.7 4949.9 4959.4 4244.6 4256.1 4256.9 4259.4 4263.6 6298.9 6572.9 6577.1 6591.0 6651.4 5795.7 5806.8 5818.3 5831.0 5865.2 7368.4 7393.3 7398.0 7401.7 7413.1 4638.5 4656.0 4660.3 4661.8 4691.3 7396.7 7690.1 7728.7 7729.2 7758.7 4531.0 4599.5 4691.3 4693.3 4700.5 4769.7 4769.9 4779.8 4796.7 4801.4 5741.2 5776.5 5801.0 5828.3 5842.8 7375.7 7377.5 7382.3 7387.1 7413.8 1637.2 1666.7 1672.1 1672.6 1673.9 787.6 1013.9 1053.9 1068.6 1069.3 5607.9 6472.9 6779.7 6798.0 6853.3 7552.8 7598.1 7598.2 7606.2 7628.5 5660.3 6540.8 6694.9 6810.9 6829.5 3989.7 4000.0 4024.8 4034.8 4034.9 7899.6 7916.1 7922.0 7923.8 7927.1 7830.6 7834.2 7849.3 7858.0 7858.6 7848.6 7870.7 7899.8 7914.0 8164.3 7568.3 7755.4 7769.5 7776.2 7787.8 7591.6 7626.3 7638.0 7657.7 7664.7 8059.7 8064.6 8070.5 8072.4 8117.0 4558.8 4683.5 4712.1 4749.8 4750.5 7388.9 7479.1 7610.0 7658.5 7734.8 7370.9 7434.7 7442.1 7445.6 7461.3 5974.0 7401.9 7432.9 7437.4 7451.3 6996.7 7234.5 7245.8 7252.2 7255.1 7431.8 7433.1 7434.4 7448.2 7457.6 7251.3 7254.3 7254.8 7266.6 7289.6 09:12:56 INFO - PROCESS | 1673 | 09:12:56 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:17220.07 Median:33887.76 stddev:24092.77 (71.1%) stddev-sans-first:24128.24 09:12:56 INFO - PROCESS | 1673 | Values: 650.8 680.2 716.6 726.7 743.7 14665.2 14851.9 14896.3 14942.2 15030.6 13675.2 13730.7 13741.2 13744.4 13791.4 680.0 835.9 836.1 844.3 860.0 838.5 839.1 843.8 846.2 852.7 865.6 885.3 895.6 896.7 898.5 864.1 879.5 889.2 892.6 893.9 660.7 663.5 670.5 672.6 673.8 14157.2 14214.5 14235.9 14270.2 14382.2 12252.0 12306.8 12370.4 12519.4 12587.7 9271.1 9467.1 9719.4 9848.4 9870.0 2877.8 2890.4 3432.8 3444.7 3516.8 59848.0 79498.2 79641.6 82246.2 82453.0 9138.5 9184.7 9187.1 9408.3 9469.3 20809.4 20950.8 20965.4 21016.0 21034.2 7373.9 7394.5 7397.4 7408.5 7600.2 4018.6 4077.4 4083.6 4094.5 4094.9 3331.6 3344.7 3369.3 3375.3 3376.5 610.1 619.9 621.7 626.3 626.6 502.4 554.6 576.3 586.8 608.1 7936.5 7965.6 8012.2 8140.4 8204.7 567.2 574.2 577.5 588.8 615.1 3759.5 3807.9 3823.3 3849.1 3904.1 78961.0 79463.2 81100.0 81724.6 82555.0 74645.0 75235.6 75634.5 76058.0 76735.0 63659.4 64609.7 67105.0 67612.3 67782.1 7676.0 7708.9 7759.6 7782.1 7784.0 47341.3 49158.5 49300.0 49453.5 49959.8 63528.0 64611.0 64696.7 64911.0 65605.0 9756.9 9960.4 10014.8 10029.4 10340.2 10044.8 10257.5 10310.8 10387.3 10454.2 9712.8 9806.4 9878.0 9997.4 10053.4 7679.8 9697.5 10218.4 10260.9 10670.0 9812.7 9843.1 9849.2 10025.9 10134.0 8476.5 8606.3 8639.0 8679.0 8750.9 8645.4 8665.5 8747.2 9386.4 9513.8 09:12:56 INFO - PROCESS | 1673 | -------- Summary: end -------- 09:12:56 INFO - PROCESS | 1673 | 09:12:57 INFO - TEST-INFO | 1673: exit 0 09:12:57 INFO - TEST-OK | dromaeo_css | took 1110368ms 09:12:57 INFO - TEST-START | kraken 09:12:57 INFO - operating with platform_type : mac_ 09:12:57 INFO - Initialising browser for kraken test... 09:12:57 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpvC4SbF/profile http://localhost:49281/getInfo.html) 09:13:00 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 09:13:00 INFO - PROCESS | 1685 | colorDepth:24 09:13:00 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 09:13:00 INFO - PROCESS | 1685 | __metrics 09:13:00 ERROR - PROCESS | 1685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:13:00 INFO - TEST-INFO | 1685: exit 0 09:13:00 INFO - Browser initialized. 09:13:00 INFO - Running cycle 1/1 for kraken test... 09:13:00 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpvC4SbF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:12 INFO - PROCESS | 1688 | RSS: Main: 254074880 09:13:12 INFO - PROCESS | 1688 | 09:13:15 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:16 INFO - PROCESS | 1688 | RSS: Main: 269049856 09:13:16 INFO - PROCESS | 1688 | 09:13:19 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 09:13:19 INFO - PROCESS | 1688 | RSS: Main: 276946944 09:13:19 INFO - PROCESS | 1688 | 09:13:23 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 09:13:23 INFO - PROCESS | 1688 | RSS: Main: 280977408 09:13:23 INFO - PROCESS | 1688 | 09:13:25 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 09:13:26 INFO - PROCESS | 1688 | RSS: Main: 281174016 09:13:26 INFO - PROCESS | 1688 | 09:13:28 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:29 INFO - PROCESS | 1688 | RSS: Main: 281874432 09:13:29 INFO - PROCESS | 1688 | 09:13:31 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:32 INFO - PROCESS | 1688 | RSS: Main: 283455488 09:13:32 INFO - PROCESS | 1688 | 09:13:35 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:35 INFO - PROCESS | 1688 | RSS: Main: 283443200 09:13:35 INFO - PROCESS | 1688 | 09:13:38 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 09:13:39 INFO - PROCESS | 1688 | RSS: Main: 283582464 09:13:39 INFO - PROCESS | 1688 | 09:13:40 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:41 INFO - PROCESS | 1688 | RSS: Main: 284434432 09:13:41 INFO - PROCESS | 1688 | 09:13:43 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:43 INFO - PROCESS | 1688 | RSS: Main: 282886144 09:13:43 INFO - PROCESS | 1688 | 09:13:45 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:46 INFO - PROCESS | 1688 | RSS: Main: 282361856 09:13:46 INFO - PROCESS | 1688 | 09:13:49 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:49 INFO - PROCESS | 1688 | RSS: Main: 282537984 09:13:49 INFO - PROCESS | 1688 | 09:13:52 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:52 INFO - PROCESS | 1688 | RSS: Main: 284069888 09:13:52 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 09:13:54 INFO - PROCESS | 1688 | RSS: Main: 285016064 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | __start_tp_report 09:13:54 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 09:13:54 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 09:13:54 INFO - PROCESS | 1688 | |i|pagename|runs| 09:13:54 INFO - PROCESS | 1688 | |0;ai-astar;131;145;116;144;170;184;114;119;120;161 09:13:54 INFO - PROCESS | 1688 | |1;audio-beat-detection;167;154;179;178;120;159;172;123;161;127 09:13:54 INFO - PROCESS | 1688 | |2;audio-dft;188;269;273;202;197;199;197;196;201;196 09:13:54 INFO - PROCESS | 1688 | |3;audio-fft;70;73;70;125;65;82;85;81;77;57 09:13:54 INFO - PROCESS | 1688 | |4;audio-oscillator;83;81;124;82;79;82;118;79;79;114 09:13:54 INFO - PROCESS | 1688 | |5;imaging-gaussian-blur;88;86;92;85;84;132;133;87;89;85 09:13:54 INFO - PROCESS | 1688 | |6;imaging-darkroom;154;95;96;95;94;95;96;94;94;96 09:13:54 INFO - PROCESS | 1688 | |7;imaging-desaturate;92;93;90;97;93;91;137;94;75;76 09:13:54 INFO - PROCESS | 1688 | |8;json-parse-financial;58;57;55;56;58;56;57;62;57;54 09:13:54 INFO - PROCESS | 1688 | |9;json-stringify-tinderbox;63;67;86;62;77;74;69;65;66;71 09:13:54 INFO - PROCESS | 1688 | |10;stanford-crypto-aes;85;86;83;87;85;89;86;86;87;80 09:13:54 INFO - PROCESS | 1688 | |11;stanford-crypto-ccm;127;125;135;142;139;115;136;134;138;136 09:13:54 INFO - PROCESS | 1688 | |12;stanford-crypto-pbkdf2;129;144;145;140;140;140;152;162;141;128 09:13:54 INFO - PROCESS | 1688 | |13;stanford-crypto-sha256-iterative;67;69;66;68;68;68;68;69;69;69 09:13:54 INFO - PROCESS | 1688 | __end_tp_report 09:13:54 INFO - PROCESS | 1688 | __start_cc_report 09:13:54 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,881 09:13:54 INFO - PROCESS | 1688 | __end_cc_report 09:13:54 INFO - PROCESS | 1688 | __startTimestamp1456938834841__endTimestamp 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | ------- Summary: start ------- 09:13:54 INFO - PROCESS | 1688 | Number of tests: 14 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#0] ai-astar Cycles:10 Average:140.40 Median:144.50 stddev:24.70 (17.1%) stddev-sans-first:25.96 09:13:54 INFO - PROCESS | 1688 | Values: 131.0 145.0 116.0 144.0 170.0 184.0 114.0 119.0 120.0 161.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:164.00 stddev:22.64 (13.8%) stddev-sans-first:23.52 09:13:54 INFO - PROCESS | 1688 | Values: 167.0 154.0 179.0 178.0 120.0 159.0 172.0 123.0 161.0 127.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#2] audio-dft Cycles:10 Average:211.80 Median:200.00 stddev:31.44 (15.7%) stddev-sans-first:32.15 09:13:54 INFO - PROCESS | 1688 | Values: 188.0 269.0 273.0 202.0 197.0 199.0 197.0 196.0 201.0 196.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#3] audio-fft Cycles:10 Average:78.50 Median:75.00 stddev:18.39 (24.5%) stddev-sans-first:19.25 09:13:54 INFO - PROCESS | 1688 | Values: 70.0 73.0 70.0 125.0 65.0 82.0 85.0 81.0 77.0 57.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:80.00 stddev:18.54 (23.2%) stddev-sans-first:19.37 09:13:54 INFO - PROCESS | 1688 | Values: 83.0 81.0 124.0 82.0 79.0 82.0 118.0 79.0 79.0 114.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:86.50 stddev:19.32 (22.3%) stddev-sans-first:20.27 09:13:54 INFO - PROCESS | 1688 | Values: 88.0 86.0 92.0 85.0 84.0 132.0 133.0 87.0 89.0 85.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:95.00 stddev:18.68 (19.7%) stddev-sans-first:0.87 09:13:54 INFO - PROCESS | 1688 | Values: 154.0 95.0 96.0 95.0 94.0 95.0 96.0 94.0 94.0 96.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:92.50 stddev:16.91 (18.3%) stddev-sans-first:17.92 09:13:54 INFO - PROCESS | 1688 | Values: 92.0 93.0 90.0 97.0 93.0 91.0 137.0 94.0 75.0 76.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:2.16 (3.8%) stddev-sans-first:2.26 09:13:54 INFO - PROCESS | 1688 | Values: 58.0 57.0 55.0 56.0 58.0 56.0 57.0 62.0 57.0 54.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:7.35 (10.5%) stddev-sans-first:7.34 09:13:54 INFO - PROCESS | 1688 | Values: 63.0 67.0 86.0 62.0 77.0 74.0 69.0 65.0 66.0 71.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:2.46 (2.9%) stddev-sans-first:2.60 09:13:54 INFO - PROCESS | 1688 | Values: 85.0 86.0 83.0 87.0 85.0 89.0 86.0 86.0 87.0 80.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:136.00 stddev:8.08 (5.9%) stddev-sans-first:8.31 09:13:54 INFO - PROCESS | 1688 | Values: 127.0 125.0 135.0 142.0 139.0 115.0 136.0 134.0 138.0 136.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.10 Median:142.50 stddev:9.95 (7.0%) stddev-sans-first:9.36 09:13:54 INFO - PROCESS | 1688 | Values: 129.0 144.0 145.0 140.0 140.0 140.0 152.0 162.0 141.0 128.0 09:13:54 INFO - PROCESS | 1688 | 09:13:54 INFO - PROCESS | 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:0.99 (1.5%) stddev-sans-first:0.97 09:13:54 INFO - PROCESS | 1688 | Values: 67.0 69.0 66.0 68.0 68.0 68.0 68.0 69.0 69.0 69.0 09:13:54 INFO - PROCESS | 1688 | -------- Summary: end -------- 09:13:54 INFO - PROCESS | 1688 | 09:13:55 INFO - TEST-INFO | 1688: exit 0 09:13:55 INFO - TEST-OK | kraken | took 58401ms 09:13:55 INFO - SUITE-END | took 1168s 09:13:56 INFO - Completed test suite (00:19:29) 09:13:56 INFO - Working with test: dromaeo_css 09:13:56 INFO - Generating results file: dromaeo_css 09:13:56 INFO - Working with test: kraken 09:13:56 INFO - Generating results file: kraken 09:13:56 INFO - javascript benchmark 09:13:56 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:13:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 09:13:56 INFO - process_Request line: dromaeo_css 7419.88 graph.html#tests=[[72,64,61]] 09:13:56 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:13:56 INFO - process_Request line: kraken 1522.90 graph.html#tests=[[232,64,61]] 09:13:56 INFO - RETURN: dromaeo_css: 7419.88 09:13:56 INFO - RETURN: kraken: 1522.90 09:13:56 INFO - javascript benchmark 09:13:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2822.7177282271778, 3484.2508860594967, 3520.8767693130744, 3541.4510750833615, 3562.251927095309, 5655.0386434306165, 5660.518855897254, 5669.291338582682, 5704.743286552105, 5707.4577915098, 5494.587905907053, 5630.324361076667, 5705.115707065401, 5709.571782116337, 5826.504747096491, 5089.134847075988, 5120.743962801864, 5154.639175257734, 5183.3779946406485, 5200.869978250536, 5154.175331946889, 5163.922541161885, 5190.2474141249495, 5212.609054320922, 5213.973930130344, 5049.0, 5055.0900837848985, 5072.492750724935, 5113.156329205676, 5113.744312784346, 4362.585554372329, 4965.280034394992, 5099.36257967754, 5112.309838171836, 5146.253793200002, 4034.5965403459713, 4719.221328480797, 4992.6005919526715, 5042.495750424965, 5082.390113186404, 4135.7932103395015, 5542.168674698787, 5620.1288800236025, 5624.0439125348785, 5653.840962602698, 6162.969185154046, 6197.907031394533, 6201.937980620181, 6213.13016177731, 6219.1915051043525, 6109.5112391008615, 6151.661658608775, 6179.6292222466345, 6210.099535567318, 6223.68881555925, 5799.130130480377, 5813.6802475863815, 5821.097729851922, 5825.912611310791, 5831.416858314177, 6220.626762394271, 6234.251889773256, 6242.75028998844, 6248.625082495065, 6310.368963103653, 5972.611780234271, 6081.817545473643, 6108.9795837225665, 6130.203073600493, 6135.84660383494, 5674.4892959633835, 6049.0, 6172.444479996821, 6196.411340922605, 6204.81385558434, 6105.2799457750825, 6126.090206827809, 6130.122981477994, 6148.815535533941, 6163.137160797492, 6076.453119219292, 6097.706167156134, 6133.233345831771, 6172.722227499684, 6179.104029915727, 4104.035551645361, 4810.903781924412, 4853.223484242504, 4860.975695121501, 4867.440244371872, 4357.9782101089295, 4398.362237475548, 4410.889727756832, 4434.711743736647, 4469.262571675637, 5587.636803607753, 5665.688387138664, 5703.9429605704245, 5714.7428365723645, 5750.971245143747, 6202.596831206048, 6204.069389591597, 6206.255249370104, 6223.813285601439, 6232.719527621268, 4642.442906851199, 5187.896242075138, 5520.227168196456, 5669.319681638147, 5719.170720245541, 5249.553787927993, 5295.814646487432, 5302.469753024667, 5303.973480132575, 5350.892982140335, 6255.0, 6261.217347831521, 6266.0, 6266.248050234001, 6284.0, 5182.222666600041, 6096.254562767794, 6131.223750760645, 6192.535559832941, 6220.377962203744, 5806.664467172658, 5825.825225243249, 6189.319174890668, 6256.718447669957, 6273.341299163522, 6072.423119803611, 6085.482733967662, 6113.0, 6128.111423843607, 6140.4473597376455, 5418.593605479526, 6051.062085376773, 6066.241719785027, 6068.544859135494, 6124.295705993868, 5986.2517185351835, 6008.699565021644, 6075.210222671025, 6110.938890611037, 6135.631862088289, 5748.6838223898085, 6039.396060394101, 6096.29892562361, 6103.267607887082, 6113.419225173601, 5671.858203544944, 5817.76728930838, 5855.970720146372, 5988.940110598838, 6044.15381846533, 6040.244969378828, 6046.697665116639, 6080.118382834553, 6101.084837274444, 6141.508679305555, 5984.790532331522, 5990.880182396415, 5998.670073145844, 6000.129981152621, 6003.249593800775], "unit": "score", "name": "dojo.html", "value": 5596.361184681758}, {"lowerIsBetter": false, "replicates": [429.1459994610724, 476.4401827852275, 476.48539577256565, 563.7913971830422, 598.1118039711031, 37463.43804842929, 38073.619263807355, 38148.80925595368, 38181.61818381815, 38235.61764382362, 39153.80423097888, 39386.0, 39408.817735467914, 39582.01044973877, 39697.40453893186, 9355.672551460717, 9623.759406014871, 9633.518324083803, 9635.325527213097, 9637.132658060773, 9546.809063818719, 9682.903170968306, 9689.515524223796, 9701.320907536476, 9706.70879873605, 9631.71104866855, 9692.369995950276, 9742.51287435629, 9744.0, 9752.36609620376, 9576.946535881047, 9683.757906052335, 9686.176674982635, 9691.709248722585, 9770.316077874551, 9497.762555936088, 9641.084097010773, 9665.323427360088, 9677.0, 9685.661001864972, 37941.0, 38469.61530384716, 38503.807480962416, 38648.0, 38731.0, 3154.2587491939375, 3171.1913462067255, 3297.0, 3561.786292822439, 4026.4362989181536, 27474.862625686943, 27653.446931061466, 27788.444231115467, 27854.0, 28485.0, 2745.217612980311, 2748.1480740970364, 2769.9030533931214, 2863.21261653045, 2914.941701165965, 354858.99999999744, 384302.0, 406825.0, 411197.0, 411631.0, 63113.36886631167, 63412.0, 63641.0, 63704.04443933345, 63745.0, 71652.0, 72130.9180362295, 72862.27137728555, 73184.26815731882, 73490.26509734834, 16165.59586010359, 16211.675766484841, 16246.837531624533, 16407.0, 16436.931599445998, 12411.875881241253, 12506.499740010298, 12556.0, 12566.434510447052, 12607.054470914718, 21114.366569002956, 21170.894145529175, 21244.787552124282, 21278.936053197278, 21289.254876079263, 9025.23285520725, 9268.212201962908, 9291.907080929104, 9321.44071355721, 9333.0, 886.9157430044136, 1009.2329829329763, 1051.2063392138887, 1058.8035519862506, 1119.339589642115, 29380.559291610643, 29672.1098367045, 29674.66069903237, 30046.69953300439, 30702.771889124186, 854.5086575219274, 1039.0856046678873, 1073.2380010192694, 1086.4079076903106, 1201.567435723139, 11923.926846583849, 13801.51694690681, 14407.855921440652, 14524.709505809824, 14707.852921470649, 530791.0, 531787.0, 537997.0, 539097.0, 539520.0, 58020.41979580234, 58301.4169858296, 58755.706221468616, 58989.70505147533, 59252.70373648104, 1343.1135450602555, 1374.202962281894, 1413.4699487692114, 1417.397606017459, 1417.4188582681256, 25173.87413062923, 26275.4744905097, 27268.590971135847, 28814.423711525233, 29333.41333173367, 43917.902052448946, 46534.30198546957, 50501.989960199855, 51371.0, 51764.48235517597, 491030.0, 496611.0, 499522.0, 503312.41718955856, 505140.0, 33331.83334083411, 33388.99833005014, 33572.49641255432, 33631.831840841616, 34133.65866341305, 44945.32582011338, 45041.09917801691, 45436.77281613571, 45840.624781256614, 46330.84172895704, 32075.839620801748, 37131.443028355134, 37396.62603373932, 37434.87695369143, 37913.81043094767, 30456.695433045385, 36606.267874642894, 36742.44886326761, 37076.62923370732, 37188.0, 29602.0, 36185.0, 36747.89756307315, 37058.444123337635, 37925.0, 31998.0, 32236.83881580577, 32759.0, 38700.6129938697, 39931.40102898517, 29937.850310749178, 30548.694513054586, 30966.845165774026, 31335.373292534478, 31389.744410223335], "unit": "score", "name": "ext.html", "value": 19804.328487699575}, {"lowerIsBetter": false, "replicates": [305.58135354564246, 351.10468305820166, 358.19048949374405, 358.9892303230904, 364.18967796652436, 19122.0, 19137.42587722367, 20441.0, 20462.693059604117, 20496.282630107948, 18852.151653175606, 19235.807641923577, 19353.032348382596, 19418.02909854509, 19440.805591944078, 5383.300170977777, 5644.604877658545, 5684.062129748587, 5686.886262274752, 5706.058500347438, 4110.280700877334, 5626.521745651625, 5937.367224013409, 6188.47397971173, 6202.4727898128485, 6139.048447490623, 6156.846078848042, 6158.6612736299485, 6161.599496032766, 6167.136600875881, 5897.793577224798, 6176.382361763787, 6177.0, 6178.598391104564, 6186.783462578811, 4465.173942820588, 5209.661372010845, 5233.371995360543, 5326.627136100475, 5351.331083614548, 24028.0, 24476.265712028668, 24791.752082479125, 24807.875960620262, 24845.751542484526, 2068.8758674479577, 2105.884176370299, 2312.90748370065, 2318.6637937498967, 2508.83692559983, 14275.21486318252, 14462.78305825403, 14551.636209094751, 14661.92669036648, 14986.925065374604, 1687.9324827006906, 1690.1464760296094, 1741.7126174181244, 1767.1252729898654, 1767.8939263644222, 107004.39493407604, 108338.0, 109980.25095254225, 110396.89603103946, 111803.0, 8364.247217750431, 8531.616077276538, 10140.391576505433, 10549.20880933933, 10608.363498190134, 12491.188072775241, 12546.184498007782, 12556.246625202517, 12655.493780248871, 12681.492740290285, 6815.182178138655, 8146.0, 8292.17078292178, 8387.538685372241, 8472.068072512018, 7027.754028609076, 7372.557646541225, 8562.015368232609, 8655.567221638892, 8765.991910930197, 5906.616069955439, 6062.575619706578, 6144.109104179958, 6144.477719393902, 6234.127222188898, 1490.6646004649085, 1676.5640933357415, 1726.2231995602028, 1799.379214171109, 1810.248746770102, 875.9956200218958, 879.8064425826308, 882.8013696918142, 933.178802653674, 961.5192403798101, 16947.40684076076, 19195.61608767817, 19754.60490790205, 19888.801111988694, 19996.60006799856, 926.7683079230193, 948.8339540580508, 981.16600889245, 1008.6520150548049, 1041.109851077318, 11067.778644427066, 11301.547938082385, 11323.0, 11357.943210283896, 11358.148138889615, 574675.0, 581989.0, 586401.0, 650713.0, 662658.0, 110006.0, 117547.88582399575, 120064.0, 120875.0, 127926.0, 455.8609624064626, 478.66732620828884, 479.0443066083117, 480.06627110270887, 1007.9294449388473, 9772.804543909224, 17395.04327262013, 17674.0, 19304.71042934329, 19318.8068119317, 34575.0, 51680.707982300744, 51800.74099629478, 51860.96278074493, 53414.0, 67877.9273243607, 70203.0, 70730.0, 71068.64465677639, 71341.57316853738, 7829.608519573884, 7906.5651389174145, 7926.762197134095, 7992.640331185227, 8177.754667359989, 9666.56500457467, 12776.6805829855, 12967.740645187232, 13049.34753262352, 13161.605151845077, 11040.834387484354, 11192.832107518556, 11309.886901130883, 11529.596464123715, 11789.292642441482, 8776.297896168164, 11128.721781955192, 11345.716357091138, 11415.486303116546, 11532.59635912739, 11274.549018039186, 11511.827322590001, 11642.53429862796, 11665.00847427978, 11797.76404471923, 7612.200718924433, 8076.798080048045, 8079.757607271791, 8380.916190838014, 8399.790005249917, 9746.463944482837, 10852.403117828595, 10902.618408355669, 11420.371879546372, 11641.53433862636], "unit": "score", "name": "jquery.html", "value": 9244.317496938622}, {"lowerIsBetter": false, "replicates": [1311.4360824845317, 1544.3050627217756, 1725.404735366299, 1726.3094762095152, 1847.0303090877287, 7108.964455177716, 8147.796305092375, 8373.12082231366, 8437.746867593967, 8646.783830404234, 8423.536705481196, 8518.105598912118, 8569.614367353468, 8585.699500517483, 8631.784205394868, 2270.546850015991, 2396.484755777512, 2405.290439320405, 2410.1323523531514, 2419.903203871843, 2167.7073595064703, 2382.8570285782907, 2417.407735104893, 2436.2204094689705, 2446.706395232575, 2400.0879665726998, 2414.6015907375263, 2420.4190994161363, 2431.2098567965395, 2440.3289095498703, 2384.6899903012672, 2403.170906037414, 2409.566278069938, 2415.867127307997, 2420.455397535558, 2377.2511658827416, 2408.4099395648004, 2412.433078226615, 2415.347856078849, 2417.1177520205174, 7653.693852245903, 8429.662813487454, 8525.19010693983, 8573.914260857375, 8676.305895528343, 4470.307102399133, 5160.122779127557, 5298.36419629643, 5333.653312534673, 5346.438623944468, 3510.5611798525183, 3517.6482351764876, 3549.2014296783277, 3581.1047238190454, 3627.093226693327, 967.617790972569, 982.6167794560128, 1002.7693630465034, 1615.878809089323, 1658.9502314930571, 11441.313521188755, 11527.020203282731, 11567.710807229803, 11570.826437603442, 11590.594329198522, 4515.322701594787, 4577.0, 4632.907341853144, 4655.3249778782565, 4669.859904202879, 8946.552672366355, 9048.185663290336, 9054.637814487478, 9073.001969783318, 9075.047120052299, 5177.990291893045, 5198.012377648235, 5208.192730126836, 5219.08665983459, 5228.7908483660985, 4325.610695037399, 4646.512116227815, 4736.573708366263, 4762.190427627312, 4841.491643377465, 3620.7827530348263, 3691.501647277637, 3694.852205911787, 3727.8881633550495, 3747.3254814133174, 1173.565780661161, 1179.7168679516853, 1182.8403165572709, 1183.207251141737, 1185.3836005277208, 1324.9271290078946, 1332.4203971272527, 1352.1008529328083, 1363.0526783885105, 1368.0902200036865, 7876.606169691492, 7947.721829735931, 8056.234657707509, 8062.072861620872, 8070.0, 492.3746841511261, 498.4990084964587, 504.8990201959623, 506.27349753104414, 506.47832732285804, 6036.3360030396625, 6076.0, 6090.665013424305, 6164.599301045418, 6164.660943648053, 9396.765080873032, 10235.976402359704, 10264.0, 10278.486075696186, 10378.532966016548, 9068.773280667903, 10070.69787906364, 10143.64497242593, 10207.693769186937, 10223.897761022294, 7846.254605812439, 7897.447178697436, 7911.129775724666, 7970.840583188304, 8041.276285134366, 7730.304272615492, 7736.303732664087, 7774.727884524014, 7821.022372203474, 7915.485493442908, 9185.632574696938, 9425.0, 9463.905360946303, 9524.23806095497, 9614.519274036411, 9490.715278541655, 9626.085521875411, 9757.268204884804, 9764.316497845082, 9916.851247231441, 6668.699908504032, 7007.509474336747, 7230.602316872622, 7327.560346379234, 7415.147258065176, 6575.473962083118, 6684.498662600422, 7958.801029974297, 8010.078840933367, 8037.879431808645, 6971.163460384786, 7065.6467176639935, 7067.787966361017, 7171.318724721144, 7200.0, 6954.860902782018, 6960.547564408297, 6973.965130174317, 7073.71705131789, 7088.822779430556, 7453.217412171643, 7513.812154696177, 7517.736879209201, 7580.620968951641, 7591.240875912365, 6862.210845752802, 6868.484863635147, 6880.311968803079, 6894.448444124559, 6906.896396553955, 6894.0, 6948.062011628365, 7010.719571217094, 7010.754623588354, 7013.193482749549], "unit": "score", "name": "mootools.html", "value": 4700.148517274722}, {"lowerIsBetter": false, "replicates": [315.4511150597959, 321.1617677860783, 327.62071678234634, 328.34331337325347, 330.0527486114851, 5896.675682837442, 6760.66196690166, 6800.4559635229125, 6832.2142953560415, 6861.416779573736, 6665.366790154928, 6798.252192258848, 6802.013708012335, 6830.316968303179, 6844.726210951556, 4700.670953033289, 4732.1482133216, 4938.456769755342, 4940.209566469365, 4980.02889436561, 4935.087008903346, 4950.084234416627, 4950.603951683856, 4951.034548263072, 4962.42932062812, 4870.245112007645, 4875.926861097087, 4879.268109783526, 4925.876853078666, 4927.457979622239, 4905.705657660534, 4940.90118197634, 4947.703137811743, 4949.851504454872, 4959.429665588467, 4244.596763307481, 4256.063665993476, 4256.851010214658, 4259.424977628011, 4263.637590804754, 6298.905516417258, 6572.882609956271, 6577.079208910708, 6590.967045164792, 6651.368120028589, 5795.710214489301, 5806.767729290823, 5818.301803783531, 5831.0, 5865.237519122529, 7368.410527157815, 7393.2606739326175, 7398.0, 7401.666924988334, 7413.073365829271, 4638.512956139591, 4655.976720116411, 4660.324252983332, 4661.7902194400995, 4691.3432119503295, 7396.741114060982, 7690.115636701739, 7728.729494467667, 7729.227077292282, 7758.728444504415, 4530.954690453119, 4599.494055653875, 4691.272852707836, 4693.319468677023, 4700.529947005272, 4769.689970151929, 4769.902922327884, 4779.761011949388, 4796.712197268175, 4801.375821143229, 5741.19623252745, 5776.537876969916, 5801.013827649225, 5828.271466066742, 5842.766289348378, 7375.704971801068, 7377.483576149725, 7382.261773822682, 7387.1135463744695, 7413.777586672409, 1637.2223193982763, 1666.7416550434702, 1672.1304921440783, 1672.5902153972354, 1673.9414120505967, 787.649495974286, 1013.9391636501833, 1053.9420331881668, 1068.5672302717412, 1069.3049517813329, 5607.8503906699025, 6472.870542589216, 6779.72881084751, 6797.966010169917, 6853.26497059104, 7552.848943021108, 7598.088229412506, 7598.20218877021, 7606.201348858401, 7628.504147230412, 5660.349059858087, 6540.803775886731, 6694.933050669431, 6810.863782724317, 6829.453643708492, 3989.7207195496617, 4000.0199951012187, 4024.75851448914, 4034.838606455709, 4034.8789536313957, 7899.605019748989, 7916.050073991158, 7922.049354077432, 7923.801904952422, 7927.0883848357025, 7830.62963981301, 7834.1774113718375, 7849.3328067114935, 7858.0, 7858.5677787722225, 7848.568328741974, 7870.72452464161, 7899.842003159904, 7914.0, 8164.30603398694, 7568.318851303409, 7755.379569634529, 7769.456138070507, 7776.222377762178, 7787.805304867424, 7591.620418978919, 7626.275503827128, 7638.045244344457, 7657.731979380695, 7664.73173438927, 8059.717909873127, 8064.55644939534, 8070.47541909774, 8072.354211663171, 8116.959415202886, 4558.772061396983, 4683.484816670231, 4712.081144176853, 4749.7625118743235, 4750.477447480705, 7388.926110738824, 7479.065116860393, 7610.048743907012, 7658.4639075264195, 7734.7679569613, 7370.852582948418, 7434.702611895464, 7442.144153422426, 7445.553266804009, 7461.328480436787, 5974.0, 7401.925980740339, 7432.888506672296, 7437.405007599271, 7451.254874512505, 6996.685149168198, 7234.529755565872, 7245.7826265212125, 7252.238514956065, 7255.129384473897, 7431.8142046449275, 7433.145188303414, 7434.36807871337, 7448.180700123091, 7457.6271186441545, 7251.347378735939, 7254.274572542915, 7254.782356529313, 7266.636668166676, 7289.635518224173], "unit": "score", "name": "prototype.html", "value": 5311.783330712695}, {"lowerIsBetter": false, "replicates": [650.8145178624093, 680.1769858471249, 716.6237725194276, 726.6621021225131, 743.6988019851958, 14665.193414362206, 14851.925740371284, 14896.25518724065, 14942.178180200084, 15030.624234394145, 13675.179489230653, 13730.65673358164, 13741.175529468239, 13744.381502832372, 13791.379387927542, 680.0309558878578, 835.8787975743513, 836.1053672570337, 844.3287586368851, 859.9613017414231, 838.4633834346023, 839.0686338164633, 843.755310959824, 846.1580727176437, 852.6631980367752, 865.5974971638187, 885.2608072259671, 895.5656506594297, 896.6906417286059, 898.4743924803964, 864.1358641358642, 879.4898958603994, 889.168627333442, 892.6117139044504, 893.8793262909489, 660.6762686283735, 663.4625952978104, 670.5272782688193, 672.5695554844904, 673.8012286375531, 14157.150570965672, 14214.50249241282, 14235.928820355935, 14270.215138167398, 14382.208978506282, 12252.0, 12306.81539776904, 12370.381480925918, 12519.3740312984, 12587.74824503514, 9271.119243671841, 9467.147956683863, 9719.368241064309, 9848.409095454295, 9869.950650246774, 2877.8129421587737, 2890.3930174663346, 3432.845521951518, 3444.6555344465605, 3516.841742121611, 59848.0, 79498.20501794966, 79641.60179199067, 82246.17753822445, 82453.0, 9138.54307284633, 9184.724458266262, 9187.070715149894, 9408.294377921684, 9469.337146399823, 20809.37571872846, 20950.790492095188, 20965.37103886886, 21016.0, 21034.158633654788, 7373.926260737431, 7394.482386232912, 7397.445191610651, 7408.518446300973, 7600.201978792147, 4018.598140185958, 4077.408775727503, 4083.612056854594, 4094.5086589609436, 4094.856680016245, 3331.6002079750583, 3344.73242140633, 3369.292448585775, 3375.3080618473155, 3376.544166537486, 610.0696437932189, 619.8853212155766, 621.6611946489174, 626.2735227136591, 626.6240255846546, 502.412177752031, 554.6006875049958, 576.2911618709012, 586.7652938824505, 608.0969759906535, 7936.4841285317425, 7965.56189409588, 8012.238837310446, 8140.389470789714, 8204.671813127408, 567.2257368691706, 574.2420005592578, 577.4802677590202, 588.802751078385, 615.1050221927086, 3759.5112635357777, 3807.923841523154, 3823.2735780201674, 3849.1147036181833, 3904.141088960424, 78961.0, 79463.20536794674, 81100.0, 81724.59137704273, 82555.0, 74645.0, 75235.62382188163, 75634.48731025349, 76058.0, 76735.0, 63659.36340636627, 64609.67695161588, 67105.0, 67612.32387676061, 67782.08488206333, 7675.961620191863, 7708.884366734392, 7759.61201939912, 7782.143964164051, 7784.0, 47341.289880652505, 49158.508414916825, 49300.013999719085, 49453.50546494489, 49959.75020124876, 63528.047079294774, 64611.0, 64696.67651661712, 64911.0, 65605.0, 9756.902430975599, 9960.402375857471, 10014.849777253492, 10029.398236105566, 10340.224483163944, 10044.849327260243, 10257.487125643538, 10310.845337319795, 10387.324823886423, 10454.215933805148, 9712.75718107053, 9806.362586431858, 9878.0, 9997.350172238781, 10053.396796192252, 7679.769606911802, 9697.466639334903, 10218.437985910548, 10260.948695256477, 10670.0, 9812.65655702047, 9843.064908833936, 9849.212063034796, 10025.899741002788, 10133.986601339808, 8476.49141051539, 8606.311495080503, 8639.0, 8678.956605216934, 8750.91249087501, 8645.351598630003, 8665.480071195749, 8747.16901894319, 9386.436813791195, 9513.76215594588], "unit": "score", "name": "yui.html", "value": 6523.073420988244}], "name": "dromaeo_css", "value": 7419.879073520774}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [131.0, 145.0, 116.0, 144.0, 170.0, 184.0, 114.0, 119.0, 120.0, 161.0], "unit": "score", "name": "ai-astar", "value": 140.4}, {"lowerIsBetter": true, "replicates": [167.0, 154.0, 179.0, 178.0, 120.0, 159.0, 172.0, 123.0, 161.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 154.0}, {"lowerIsBetter": true, "replicates": [188.0, 269.0, 273.0, 202.0, 197.0, 199.0, 197.0, 196.0, 201.0, 196.0], "unit": "score", "name": "audio-dft", "value": 211.8}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 70.0, 125.0, 65.0, 82.0, 85.0, 81.0, 77.0, 57.0], "unit": "score", "name": "audio-fft", "value": 78.5}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 124.0, 82.0, 79.0, 82.0, 118.0, 79.0, 79.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 92.1}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 92.0, 85.0, 84.0, 132.0, 133.0, 87.0, 89.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.1}, {"lowerIsBetter": true, "replicates": [154.0, 95.0, 96.0, 95.0, 94.0, 95.0, 96.0, 94.0, 94.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 100.9}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 90.0, 97.0, 93.0, 91.0, 137.0, 94.0, 75.0, 76.0], "unit": "score", "name": "imaging-desaturate", "value": 93.8}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 55.0, 56.0, 58.0, 56.0, 57.0, 62.0, 57.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [63.0, 67.0, 86.0, 62.0, 77.0, 74.0, 69.0, 65.0, 66.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.0}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 83.0, 87.0, 85.0, 89.0, 86.0, 86.0, 87.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [127.0, 125.0, 135.0, 142.0, 139.0, 115.0, 136.0, 134.0, 138.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.7}, {"lowerIsBetter": true, "replicates": [129.0, 144.0, 145.0, 140.0, 140.0, 140.0, 152.0, 162.0, 141.0, 128.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.1}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 66.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1522.8999999999999}]} 09:13:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1522.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7419.88"}}} 09:13:56 INFO - Return code: 0 09:13:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:13:56 ERROR - # TBPL SUCCESS # 09:13:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:13:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:13:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:13:56 INFO - 2016-03-02 09:13:56.257 screenresolution[1693:10694] starting screenresolution argv=screenresolution get 09:13:56 INFO - 2016-03-02 09:13:56.260 screenresolution[1693:10694] Display 0: 1600x1200x32@60 09:13:56 INFO - 2016-03-02 09:13:56.266 screenresolution[1694:10697] starting screenresolution argv=screenresolution list 09:13:56 INFO - Available Modes on Display 0 09:13:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:13:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:13:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:13:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:13:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:13:56 INFO - Intel Iris: 09:13:56 INFO - Chipset Model: Intel Iris 09:13:56 INFO - Type: GPU 09:13:56 INFO - Bus: Built-In 09:13:56 INFO - VRAM (Dynamic, Max): 1536 MB 09:13:56 INFO - Vendor: Intel (0x8086) 09:13:56 INFO - Device ID: 0x0a2e 09:13:56 INFO - Revision ID: 0x0009 09:13:56 INFO - Displays: 09:13:56 INFO - Display: 09:13:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:13:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:13:56 INFO - Display Serial Number: 1600x1200 60 09:13:56 INFO - Main Display: Yes 09:13:56 INFO - Mirror: Off 09:13:56 INFO - Online: Yes 09:13:56 INFO - Rotation: Supported 09:13:56 INFO - Return code: 0 09:13:56 INFO - Running post-action listener: _resource_record_post_action 09:13:56 INFO - Running post-run listener: _resource_record_post_run 09:13:57 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 39491072; Write bytes: 706454528; Read time: 436; Write time: 2023 09:13:57 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384145920; Write bytes: 377906688; Read time: 28446; Write time: 670 09:13:57 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 38536704; Write bytes: 303103488; Read time: 421; Write time: 1300 09:13:57 INFO - Running post-run listener: _upload_blobber_files 09:13:57 INFO - Blob upload gear active. 09:13:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:13:57 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 09:13:57 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'] 09:13:57 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 09:13:57 INFO - (blobuploader) - INFO - Open directory for files ... 09:13:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:13:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:13:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:59 INFO - (blobuploader) - INFO - Done attempting. 09:13:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:13:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:14:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:00 INFO - (blobuploader) - INFO - Done attempting. 09:14:00 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:00 INFO - Return code: 0 09:14:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:14:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebabdcfc3857812df4b3860244296e4975d3aaa53a8142d3c1a139ab545221256ec189ce427f8462235e60dbf26e4dc303d1eed4e46979f72b244883a8ba5150", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9199c2189e877831f9449fb672de54f2aac533bf91654d11594ccf80b6418767a00df1a38af086db598b3b790fa983edcd578aef819fe4eccb267e735cc88060"} 09:14:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:14:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:14:00 INFO - Contents: 09:14:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebabdcfc3857812df4b3860244296e4975d3aaa53a8142d3c1a139ab545221256ec189ce427f8462235e60dbf26e4dc303d1eed4e46979f72b244883a8ba5150", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9199c2189e877831f9449fb672de54f2aac533bf91654d11594ccf80b6418767a00df1a38af086db598b3b790fa983edcd578aef819fe4eccb267e735cc88060"} 09:14:00 INFO - Running post-run listener: copy_logs_to_upload_dir 09:14:00 INFO - Copying logs to upload dir... 09:14:00 INFO - mkdir: /builds/slave/test/build/upload/logs 09:14:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.736709 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-02 09:14:00.224908) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 09:14:00.228493) ========= 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.5RtI0ITUZZ/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.7lB343IyD8/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebabdcfc3857812df4b3860244296e4975d3aaa53a8142d3c1a139ab545221256ec189ce427f8462235e60dbf26e4dc303d1eed4e46979f72b244883a8ba5150", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9199c2189e877831f9449fb672de54f2aac533bf91654d11594ccf80b6418767a00df1a38af086db598b3b790fa983edcd578aef819fe4eccb267e735cc88060"} build_url:https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010991 build_url: 'https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebabdcfc3857812df4b3860244296e4975d3aaa53a8142d3c1a139ab545221256ec189ce427f8462235e60dbf26e4dc303d1eed4e46979f72b244883a8ba5150", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9199c2189e877831f9449fb672de54f2aac533bf91654d11594ccf80b6418767a00df1a38af086db598b3b790fa983edcd578aef819fe4eccb267e735cc88060"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 09:14:00.254762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 09:14:00.255101) ========= 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.5RtI0ITUZZ/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.7lB343IyD8/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005089 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 09:14:00.303786) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 09:14:00.304141) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 09:14:00.304534) ========= ========= Total master_lag: 0.25 =========