builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0024 starttime: 1455092775.09 results: success (0) buildid: 20160209233523 builduid: edd93f3115f043719f5c86a65736d761 revision: 9fd143cd5996c85e8698bdc21ed78472085f699b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.089200) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.089848) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.090309) ========= 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.UMolHtZHlK/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.m9mNMMSvwy/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005577 basedir: '/builds/slave/test' ========= master_lag: 0.14 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.237502) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.238024) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.441835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.442095) ========= 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.UMolHtZHlK/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.m9mNMMSvwy/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005776 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.547026) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.547328) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.547704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.548028) ========= 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.UMolHtZHlK/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.m9mNMMSvwy/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-10 00:26:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-02-10 00:26:15 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.248456 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.830637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.830951) ========= 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.UMolHtZHlK/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.m9mNMMSvwy/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.026120 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:15.930440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 00:26:15.930760) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9fd143cd5996c85e8698bdc21ed78472085f699b --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 9fd143cd5996c85e8698bdc21ed78472085f699b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UMolHtZHlK/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.m9mNMMSvwy/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-10 00:26:16,008 truncating revision to first 12 chars 2016-02-10 00:26:16,008 Setting DEBUG logging. 2016-02-10 00:26:16,008 attempt 1/10 2016-02-10 00:26:16,008 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9fd143cd5996?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 00:26:17,106 unpacking tar archive at: fx-team-9fd143cd5996/testing/mozharness/ program finished with exit code 0 elapsedTime=1.355768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 00:26:17.307893) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:17.308222) ========= echo 9fd143cd5996c85e8698bdc21ed78472085f699b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9fd143cd5996c85e8698bdc21ed78472085f699b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UMolHtZHlK/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.m9mNMMSvwy/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 9fd143cd5996c85e8698bdc21ed78472085f699b program finished with exit code 0 elapsedTime=0.005818 script_repo_revision: '9fd143cd5996c85e8698bdc21ed78472085f699b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:17.357310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:17.357602) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 00:26:17.371391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-02-10 00:26:17.371664) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UMolHtZHlK/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.m9mNMMSvwy/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 00:26:17 INFO - MultiFileLogger online at 20160210 00:26:17 in /builds/slave/test 00:26:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:26:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:26:17 INFO - {'append_to_log': False, 00:26:17 INFO - 'base_work_dir': '/builds/slave/test', 00:26:17 INFO - 'blob_upload_branch': 'Fx-Team', 00:26:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:26:17 INFO - 'branch': 'Fx-Team', 00:26:17 INFO - 'buildbot_json_path': 'buildprops.json', 00:26:17 INFO - 'config_files': ('talos/mac_config.py',), 00:26:17 INFO - 'default_actions': ('clobber', 00:26:17 INFO - 'read-buildbot-config', 00:26:17 INFO - 'download-and-extract', 00:26:17 INFO - 'populate-webroot', 00:26:17 INFO - 'create-virtualenv', 00:26:17 INFO - 'install', 00:26:17 INFO - 'run-tests'), 00:26:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:26:17 INFO - 'download_minidump_stackwalk': True, 00:26:17 INFO - 'download_symbols': 'ondemand', 00:26:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:26:17 INFO - 'tooltool.py': '/tools/tooltool.py', 00:26:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:26:17 INFO - '/tools/misc-python/virtualenv.py')}, 00:26:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:26:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:26:17 INFO - 'installer_path': 'installer.exe', 00:26:17 INFO - 'log_level': 'info', 00:26:17 INFO - 'log_name': 'talos', 00:26:17 INFO - 'log_to_console': True, 00:26:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:26:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:26:17 INFO - 'opt_config_files': (), 00:26:17 INFO - 'pip_index': False, 00:26:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:26:17 INFO - 'cmd': ('bash', 00:26:17 INFO - '-c', 00:26:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:26:17 INFO - 'enabled': True, 00:26:17 INFO - 'halt_on_failure': False, 00:26:17 INFO - 'name': 'check_screen_resolution'},), 00:26:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:26:17 INFO - 'cmd': ('bash', 00:26:17 INFO - '-c', 00:26:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:26:17 INFO - 'enabled': True, 00:26:17 INFO - 'halt_on_failure': False, 00:26:17 INFO - 'name': 'check_screen_resolution'},), 00:26:17 INFO - 'run_cmd_checks_enabled': True, 00:26:17 INFO - 'sps_profile': False, 00:26:17 INFO - 'sps_profile_interval': 0, 00:26:17 INFO - 'suite': 'dromaeojs', 00:26:17 INFO - 'system_bits': '32', 00:26:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:26:17 INFO - 'title': 't-yosemite-r7-0024', 00:26:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:26:17 INFO - 'use_talos_json': True, 00:26:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:26:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:26:17 INFO - 'work_dir': 'build'} 00:26:17 INFO - ##### 00:26:17 INFO - ##### Running clobber step. 00:26:17 INFO - ##### 00:26:17 INFO - Running pre-action listener: _resource_record_pre_action 00:26:17 INFO - Running main action method: clobber 00:26:17 INFO - rmtree: /builds/slave/test/build 00:26:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:26:19 INFO - Running post-action listener: _resource_record_post_action 00:26:19 INFO - ##### 00:26:19 INFO - ##### Running read-buildbot-config step. 00:26:19 INFO - ##### 00:26:19 INFO - Running pre-action listener: _resource_record_pre_action 00:26:19 INFO - Running main action method: read_buildbot_config 00:26:19 INFO - Using buildbot properties: 00:26:19 INFO - { 00:26:19 INFO - "project": "", 00:26:19 INFO - "product": "firefox", 00:26:19 INFO - "script_repo_revision": "production", 00:26:19 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 00:26:19 INFO - "repository": "", 00:26:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 00:26:19 INFO - "buildid": "20160209233523", 00:26:19 INFO - "pgo_build": "False", 00:26:19 INFO - "basedir": "/builds/slave/test", 00:26:19 INFO - "buildnumber": 359, 00:26:19 INFO - "slavename": "t-yosemite-r7-0024", 00:26:19 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 00:26:19 INFO - "platform": "yosemite_r7", 00:26:19 INFO - "scheduler": "tests-fx-team-macosx64-talos", 00:26:19 INFO - "branch": "fx-team", 00:26:19 INFO - "repo_path": "integration/fx-team", 00:26:19 INFO - "revision": "9fd143cd5996c85e8698bdc21ed78472085f699b", 00:26:19 INFO - "stage_platform": "macosx64", 00:26:19 INFO - "builduid": "edd93f3115f043719f5c86a65736d761", 00:26:19 INFO - "slavebuilddir": "test" 00:26:19 INFO - } 00:26:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 00:26:19 INFO - Running post-action listener: _resource_record_post_action 00:26:19 INFO - ##### 00:26:19 INFO - ##### Running download-and-extract step. 00:26:19 INFO - ##### 00:26:19 INFO - Running pre-action listener: _resource_record_pre_action 00:26:19 INFO - Running main action method: download_and_extract 00:26:19 INFO - mkdir: /builds/slave/test/build/tests 00:26:19 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')]} 00:26:19 INFO - https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:26:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/test_packages.json 00:26:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/test_packages.json 00:26:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:26:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:26:36 INFO - Downloaded 1277 bytes. 00:26:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:26:36 INFO - Using the following test package requirements: 00:26:36 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 00:26:36 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:26:36 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 00:26:36 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:26:36 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 00:26:36 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:26:36 INFO - u'jsshell-mac.zip'], 00:26:36 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:26:36 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 00:26:36 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 00:26:36 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:26:36 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 00:26:36 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:26:36 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 00:26:36 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:26:36 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 00:26:36 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 00:26:36 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:26:36 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 00:26:36 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:36 INFO - https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:26:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:26:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:26:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/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 00:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/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 00:26:38 INFO - Downloaded 17747109 bytes. 00:26:38 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'] 00:26:38 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 00:26:41 INFO - Return code: 0 00:26:41 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 00:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:41 INFO - https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:26:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:26:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:26:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/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 00:26:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/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 00:26:44 INFO - Downloaded 17747109 bytes. 00:26:44 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'] 00:26:44 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 00:26:48 INFO - Return code: 0 00:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:48 INFO - https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 00:26:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 00:26:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 00:26:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/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 00:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/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 00:26:49 INFO - Downloaded 10706547 bytes. 00:26:49 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'] 00:26:49 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 00:26:49 INFO - Return code: 0 00:26:49 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')]} 00:26:49 INFO - https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 00:26:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 00:26:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 00:26:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 00:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCcFjjuWT2uU1SEh40gFqg/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 00:26:55 INFO - Downloaded 111244244 bytes. 00:26:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 00:26:55 INFO - mkdir: /builds/slave/test/properties 00:26:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:26:55 INFO - Writing to file /builds/slave/test/properties/build_url 00:26:55 INFO - Contents: 00:26:55 INFO - build_url:https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 00:26:56 INFO - Running post-action listener: _resource_record_post_action 00:26:56 INFO - Running post-action listener: set_extra_try_arguments 00:26:56 INFO - ##### 00:26:56 INFO - ##### Running populate-webroot step. 00:26:56 INFO - ##### 00:26:56 INFO - Running pre-action listener: _resource_record_pre_action 00:26:56 INFO - Running main action method: populate_webroot 00:26:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:26:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:26:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:26:56 INFO - '--tppagecycles', 00:26:56 INFO - '7'], 00:26:56 INFO - 'tests': ['tsvgm']}}, 00:26:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:26:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:26:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:26:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 00:26:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:26:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:26:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:26:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:56 INFO - 'talos_options': ['--e10s'], 00:26:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:26:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:56 INFO - 'tests': ['damp', 'tps']}, 00:26:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:56 INFO - 'talos_options': ['--e10s'], 00:26:56 INFO - 'tests': ['damp', 'tps']}, 00:26:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:26:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:26:56 INFO - 'other': {'tests': ['a11yr', 00:26:56 INFO - 'ts_paint', 00:26:56 INFO - 'tpaint', 00:26:56 INFO - 'sessionrestore', 00:26:56 INFO - 'sessionrestore_no_auto_restore']}, 00:26:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:26:56 INFO - 'tests': ['a11yr', 00:26:56 INFO - 'ts_paint', 00:26:56 INFO - 'tpaint', 00:26:56 INFO - 'sessionrestore', 00:26:56 INFO - 'sessionrestore_no_auto_restore']}, 00:26:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:26:56 INFO - 'tests': ['a11yr', 00:26:56 INFO - 'ts_paint', 00:26:56 INFO - 'tpaint', 00:26:56 INFO - 'sessionrestore', 00:26:56 INFO - 'sessionrestore_no_auto_restore']}, 00:26:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:26:56 INFO - 'tests': ['a11yr', 00:26:56 INFO - 'ts_paint', 00:26:56 INFO - 'tpaint', 00:26:56 INFO - 'sessionrestore', 00:26:56 INFO - 'sessionrestore_no_auto_restore']}, 00:26:56 INFO - 'other_l64': {'tests': ['a11yr', 00:26:56 INFO - 'ts_paint', 00:26:56 INFO - 'tpaint', 00:26:56 INFO - 'sessionrestore', 00:26:56 INFO - 'sessionrestore_no_auto_restore']}, 00:26:56 INFO - 'other_nol64': {'tests': ['a11yr', 00:26:56 INFO - 'ts_paint', 00:26:56 INFO - 'tpaint', 00:26:56 INFO - 'sessionrestore', 00:26:56 INFO - 'sessionrestore_no_auto_restore']}, 00:26:56 INFO - 'svgr': {'tests': ['tsvgx', 00:26:56 INFO - 'tsvgr_opacity', 00:26:56 INFO - 'tart', 00:26:56 INFO - 'tscrollx', 00:26:56 INFO - 'cart']}, 00:26:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:26:56 INFO - 'tests': ['tsvgx', 00:26:56 INFO - 'tsvgr_opacity', 00:26:56 INFO - 'tart', 00:26:56 INFO - 'tscrollx', 00:26:56 INFO - 'cart']}, 00:26:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:56 INFO - 'tests': ['tp5o']}, 00:26:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:56 INFO - 'talos_options': ['--e10s'], 00:26:56 INFO - 'tests': ['tp5o']}, 00:26:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:56 INFO - 'talos_options': ['--xperf_path', 00:26:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:26:56 INFO - 'tests': ['tp5n']}, 00:26:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:56 INFO - 'talos_options': ['--e10s', 00:26:56 INFO - '--xperf_path', 00:26:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:26:56 INFO - 'tests': ['tp5n']}}, 00:26:56 INFO - 'talos.zip': {'path': '', 00:26:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:26:56 INFO - Running post-action listener: _resource_record_post_action 00:26:56 INFO - ##### 00:26:56 INFO - ##### Running create-virtualenv step. 00:26:56 INFO - ##### 00:26:56 INFO - Running pre-action listener: _resource_record_pre_action 00:26:56 INFO - Running main action method: create_virtualenv 00:26:56 INFO - Creating virtualenv /builds/slave/test/build/venv 00:26:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:26:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:26:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:26:56 INFO - Using real prefix '/tools/python27' 00:26:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:26:57 INFO - Installing distribute.............................................................................................................................................................................................done. 00:27:00 INFO - Installing pip.................done. 00:27:00 INFO - Return code: 0 00:27:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f84da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8554c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd222c8f6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f1d30>, '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 0x10f515db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e8b20>, '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.UMolHtZHlK/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.m9mNMMSvwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 00:27:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:27:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMolHtZHlK/Render', 00:27:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:00 INFO - 'HOME': '/Users/cltbld', 00:27:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:00 INFO - 'LOGNAME': 'cltbld', 00:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:00 INFO - 'MOZ_NO_REMOTE': '1', 00:27:00 INFO - 'NO_EM_RESTART': '1', 00:27:00 INFO - 'PAGER': '/bin/cat', 00:27:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:00 INFO - 'PWD': '/builds/slave/test', 00:27:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:00 INFO - 'SHELL': '/bin/bash', 00:27:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9mNMMSvwy/Listeners', 00:27:00 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 00:27:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:00 INFO - 'USER': 'cltbld', 00:27:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:00 INFO - 'XPC_FLAGS': '0x0', 00:27:00 INFO - 'XPC_SERVICE_NAME': '0', 00:27:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:27:00 INFO - Cleaning up... 00:27:00 INFO - Return code: 0 00:27:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f84da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8554c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd222c8f6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f1d30>, '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 0x10f515db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e8b20>, '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.UMolHtZHlK/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.m9mNMMSvwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 00:27:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 00:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:27:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMolHtZHlK/Render', 00:27:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:00 INFO - 'HOME': '/Users/cltbld', 00:27:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:00 INFO - 'LOGNAME': 'cltbld', 00:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:00 INFO - 'MOZ_NO_REMOTE': '1', 00:27:00 INFO - 'NO_EM_RESTART': '1', 00:27:00 INFO - 'PAGER': '/bin/cat', 00:27:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:00 INFO - 'PWD': '/builds/slave/test', 00:27:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:00 INFO - 'SHELL': '/bin/bash', 00:27:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9mNMMSvwy/Listeners', 00:27:00 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 00:27:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:00 INFO - 'USER': 'cltbld', 00:27:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:00 INFO - 'XPC_FLAGS': '0x0', 00:27:00 INFO - 'XPC_SERVICE_NAME': '0', 00:27:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:00 INFO - Downloading/unpacking psutil>=0.7.1 00:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:27:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:27:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:27:03 INFO - Installing collected packages: psutil 00:27:03 INFO - Running setup.py install for psutil 00:27:03 INFO - building 'psutil._psutil_osx' extension 00:27:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 00:27:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 00:27:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 00:27:04 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 00:27:04 INFO - building 'psutil._psutil_posix' extension 00:27:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 00:27:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:27:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:27:04 INFO - ^ 00:27:04 INFO - 1 warning generated. 00:27:04 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 00:27:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:27:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:27:04 INFO - Successfully installed psutil 00:27:04 INFO - Cleaning up... 00:27:04 INFO - Return code: 0 00:27:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f84da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8554c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd222c8f6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f1d30>, '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 0x10f515db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e8b20>, '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.UMolHtZHlK/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.m9mNMMSvwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 00:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMolHtZHlK/Render', 00:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:04 INFO - 'HOME': '/Users/cltbld', 00:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:04 INFO - 'LOGNAME': 'cltbld', 00:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:04 INFO - 'MOZ_NO_REMOTE': '1', 00:27:04 INFO - 'NO_EM_RESTART': '1', 00:27:04 INFO - 'PAGER': '/bin/cat', 00:27:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:04 INFO - 'PWD': '/builds/slave/test', 00:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:04 INFO - 'SHELL': '/bin/bash', 00:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9mNMMSvwy/Listeners', 00:27:04 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 00:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:04 INFO - 'USER': 'cltbld', 00:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:04 INFO - 'XPC_FLAGS': '0x0', 00:27:04 INFO - 'XPC_SERVICE_NAME': '0', 00:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:27:07 INFO - Installing collected packages: mozsystemmonitor 00:27:07 INFO - Running setup.py install for mozsystemmonitor 00:27:07 INFO - Successfully installed mozsystemmonitor 00:27:07 INFO - Cleaning up... 00:27:07 INFO - Return code: 0 00:27:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f84da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8554c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd222c8f6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f1d30>, '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 0x10f515db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e8b20>, '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.UMolHtZHlK/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.m9mNMMSvwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 00:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:27:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMolHtZHlK/Render', 00:27:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:07 INFO - 'HOME': '/Users/cltbld', 00:27:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:07 INFO - 'LOGNAME': 'cltbld', 00:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:07 INFO - 'MOZ_NO_REMOTE': '1', 00:27:07 INFO - 'NO_EM_RESTART': '1', 00:27:07 INFO - 'PAGER': '/bin/cat', 00:27:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:07 INFO - 'PWD': '/builds/slave/test', 00:27:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:07 INFO - 'SHELL': '/bin/bash', 00:27:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9mNMMSvwy/Listeners', 00:27:07 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 00:27:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:07 INFO - 'USER': 'cltbld', 00:27:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:07 INFO - 'XPC_FLAGS': '0x0', 00:27:07 INFO - 'XPC_SERVICE_NAME': '0', 00:27:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:07 INFO - Downloading/unpacking blobuploader==1.2.4 00:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:10 INFO - Downloading blobuploader-1.2.4.tar.gz 00:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:27:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:27:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:11 INFO - Downloading docopt-0.6.1.tar.gz 00:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:27:11 INFO - Installing collected packages: blobuploader, requests, docopt 00:27:11 INFO - Running setup.py install for blobuploader 00:27:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:27:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:27:11 INFO - Running setup.py install for requests 00:27:12 INFO - Running setup.py install for docopt 00:27:12 INFO - Successfully installed blobuploader requests docopt 00:27:12 INFO - Cleaning up... 00:27:12 INFO - Return code: 0 00:27:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f84da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8554c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd222c8f6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f1d30>, '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 0x10f515db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e8b20>, '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.UMolHtZHlK/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.m9mNMMSvwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 00:27:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:27:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMolHtZHlK/Render', 00:27:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:12 INFO - 'HOME': '/Users/cltbld', 00:27:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:12 INFO - 'LOGNAME': 'cltbld', 00:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:12 INFO - 'MOZ_NO_REMOTE': '1', 00:27:12 INFO - 'NO_EM_RESTART': '1', 00:27:12 INFO - 'PAGER': '/bin/cat', 00:27:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:12 INFO - 'PWD': '/builds/slave/test', 00:27:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:12 INFO - 'SHELL': '/bin/bash', 00:27:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9mNMMSvwy/Listeners', 00:27:12 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 00:27:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:12 INFO - 'USER': 'cltbld', 00:27:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:12 INFO - 'XPC_FLAGS': '0x0', 00:27:12 INFO - 'XPC_SERVICE_NAME': '0', 00:27:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:27:12 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-dAhDnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:27:12 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-fv5tSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:27:12 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-yG_jdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:27:12 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-LEBHcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:27:12 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-TXyNLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:27:13 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-b2GUPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:27:13 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-gASS1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:27:13 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-okANL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:27:13 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-oLIMpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:27:13 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-JPnggg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:27:13 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-RVYDlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:27:13 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-DYcYT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:27:13 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-SyH3Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:27:13 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ArXmhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:27:13 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-le9tol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:27:14 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-eCD9Pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:27:14 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Zw9WQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:27:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:27:14 INFO - Running setup.py install for manifestparser 00:27:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:27:14 INFO - Running setup.py install for mozcrash 00:27:14 INFO - Running setup.py install for mozdebug 00:27:14 INFO - Running setup.py install for mozdevice 00:27:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:27:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:27:14 INFO - Running setup.py install for mozfile 00:27:15 INFO - Running setup.py install for mozhttpd 00:27:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:27:15 INFO - Running setup.py install for mozinfo 00:27:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:27:15 INFO - Running setup.py install for mozInstall 00:27:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:27:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:27:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:27:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:27:15 INFO - Running setup.py install for mozleak 00:27:15 INFO - Running setup.py install for mozlog 00:27:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:27:15 INFO - Running setup.py install for moznetwork 00:27:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:27:15 INFO - Running setup.py install for mozprocess 00:27:16 INFO - Running setup.py install for mozprofile 00:27:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:27:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:27:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:27:16 INFO - Running setup.py install for mozrunner 00:27:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:27:16 INFO - Running setup.py install for mozscreenshot 00:27:16 INFO - Running setup.py install for moztest 00:27:16 INFO - Running setup.py install for mozversion 00:27:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:27:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:27:16 INFO - Cleaning up... 00:27:16 INFO - Return code: 0 00:27:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f84da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8554c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd222c8f6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f1d30>, '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 0x10f515db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e8b20>, '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.UMolHtZHlK/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.m9mNMMSvwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 00:27:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:27:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMolHtZHlK/Render', 00:27:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:16 INFO - 'HOME': '/Users/cltbld', 00:27:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:16 INFO - 'LOGNAME': 'cltbld', 00:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:16 INFO - 'MOZ_NO_REMOTE': '1', 00:27:16 INFO - 'NO_EM_RESTART': '1', 00:27:16 INFO - 'PAGER': '/bin/cat', 00:27:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:16 INFO - 'PWD': '/builds/slave/test', 00:27:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:16 INFO - 'SHELL': '/bin/bash', 00:27:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9mNMMSvwy/Listeners', 00:27:16 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 00:27:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:16 INFO - 'USER': 'cltbld', 00:27:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:16 INFO - 'XPC_FLAGS': '0x0', 00:27:16 INFO - 'XPC_SERVICE_NAME': '0', 00:27:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:27:17 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-cYawBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:27:17 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-LRwGmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:27:17 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Jy_zoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:27:17 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-J7e4Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:27:17 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-aEUxxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:27:17 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-V81aPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:27:17 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-3GqqCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:27:17 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-qCEUMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:27:17 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-7rcJ70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:27:18 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-WaEJW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:27:18 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-obi5ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:27:18 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-RHNc_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:27:18 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-V3cXyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:27:18 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-RMXN_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:27:18 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-1vY0fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:27:18 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-PQyjB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:27:18 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-NLnOub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:27:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:21 INFO - Downloading blessings-1.6.tar.gz 00:27:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:27:21 INFO - Installing collected packages: blessings 00:27:21 INFO - Running setup.py install for blessings 00:27:21 INFO - Successfully installed blessings 00:27:21 INFO - Cleaning up... 00:27:22 INFO - Return code: 0 00:27:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:27:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:27:22 INFO - Reading from file tmpfile_stdout 00:27:22 INFO - Current package versions: 00:27:22 INFO - blessings == 1.6 00:27:22 INFO - blobuploader == 1.2.4 00:27:22 INFO - docopt == 0.6.1 00:27:22 INFO - manifestparser == 1.1 00:27:22 INFO - mozInstall == 1.12 00:27:22 INFO - mozcrash == 0.16 00:27:22 INFO - mozdebug == 0.1 00:27:22 INFO - mozdevice == 0.48 00:27:22 INFO - mozfile == 1.2 00:27:22 INFO - mozhttpd == 0.7 00:27:22 INFO - mozinfo == 0.9 00:27:22 INFO - mozleak == 0.1 00:27:22 INFO - mozlog == 3.1 00:27:22 INFO - moznetwork == 0.27 00:27:22 INFO - mozprocess == 0.22 00:27:22 INFO - mozprofile == 0.28 00:27:22 INFO - mozrunner == 6.11 00:27:22 INFO - mozscreenshot == 0.1 00:27:22 INFO - mozsystemmonitor == 0.0 00:27:22 INFO - moztest == 0.7 00:27:22 INFO - mozversion == 1.4 00:27:22 INFO - psutil == 3.1.1 00:27:22 INFO - requests == 1.2.3 00:27:22 INFO - wsgiref == 0.1.2 00:27:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:22 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 0x10f84da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8554c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd222c8f6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f1d30>, '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 0x10f515db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e8b20>, '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.UMolHtZHlK/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.m9mNMMSvwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 00:27:22 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 00:27:22 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 00:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMolHtZHlK/Render', 00:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:22 INFO - 'HOME': '/Users/cltbld', 00:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:22 INFO - 'LOGNAME': 'cltbld', 00:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:22 INFO - 'MOZ_NO_REMOTE': '1', 00:27:22 INFO - 'NO_EM_RESTART': '1', 00:27:22 INFO - 'PAGER': '/bin/cat', 00:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:22 INFO - 'PWD': '/builds/slave/test', 00:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:22 INFO - 'SHELL': '/bin/bash', 00:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9mNMMSvwy/Listeners', 00:27:22 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 00:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:22 INFO - 'USER': 'cltbld', 00:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:22 INFO - 'XPC_FLAGS': '0x0', 00:27:22 INFO - 'XPC_SERVICE_NAME': '0', 00:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:27:22 INFO - Cleaning up... 00:27:22 INFO - Return code: 0 00:27:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f84da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8554c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd222c8f6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f1d30>, '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 0x10f515db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e8b20>, '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.UMolHtZHlK/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.m9mNMMSvwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 00:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMolHtZHlK/Render', 00:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:22 INFO - 'HOME': '/Users/cltbld', 00:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:22 INFO - 'LOGNAME': 'cltbld', 00:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:22 INFO - 'MOZ_NO_REMOTE': '1', 00:27:22 INFO - 'NO_EM_RESTART': '1', 00:27:22 INFO - 'PAGER': '/bin/cat', 00:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:22 INFO - 'PWD': '/builds/slave/test', 00:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:22 INFO - 'SHELL': '/bin/bash', 00:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9mNMMSvwy/Listeners', 00:27:22 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 00:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:22 INFO - 'USER': 'cltbld', 00:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:22 INFO - 'XPC_FLAGS': '0x0', 00:27:22 INFO - 'XPC_SERVICE_NAME': '0', 00:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:22 INFO - Downloading/unpacking jsonschema 00:27: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 00:27: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 00:27: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 00:27: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 00:27: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 00:27: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 00:27:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:27:25 INFO - Downloading/unpacking functools32 (from jsonschema) 00:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:25 INFO - Downloading functools32-3.2.3-2.tar.gz 00:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:27:25 INFO - warning: no files found matching '*.txt' 00:27:25 INFO - no previously-included directories found matching 'build' 00:27:25 INFO - no previously-included directories found matching 'dist' 00:27:25 INFO - no previously-included directories found matching '.git*' 00:27:25 INFO - Installing collected packages: jsonschema, functools32 00:27:25 INFO - Running setup.py install for functools32 00:27:25 INFO - warning: no files found matching '*.txt' 00:27:25 INFO - no previously-included directories found matching 'build' 00:27:25 INFO - no previously-included directories found matching 'dist' 00:27:25 INFO - no previously-included directories found matching '.git*' 00:27:25 INFO - Successfully installed jsonschema functools32 00:27:25 INFO - Cleaning up... 00:27:25 INFO - Return code: 0 00:27:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:27: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')]} 00:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27: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')]} 00:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f84da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8554c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd222c8f6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f1d30>, '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 0x10f515db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e8b20>, '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.UMolHtZHlK/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.m9mNMMSvwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 00:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 00:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:27:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMolHtZHlK/Render', 00:27:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:25 INFO - 'HOME': '/Users/cltbld', 00:27:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:25 INFO - 'LOGNAME': 'cltbld', 00:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:25 INFO - 'MOZ_NO_REMOTE': '1', 00:27:25 INFO - 'NO_EM_RESTART': '1', 00:27:25 INFO - 'PAGER': '/bin/cat', 00:27:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:25 INFO - 'PWD': '/builds/slave/test', 00:27:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:25 INFO - 'SHELL': '/bin/bash', 00:27:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9mNMMSvwy/Listeners', 00:27:25 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 00:27:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:25 INFO - 'USER': 'cltbld', 00:27:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:25 INFO - 'XPC_FLAGS': '0x0', 00:27:25 INFO - 'XPC_SERVICE_NAME': '0', 00:27:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:26 INFO - Downloading/unpacking flake8 00:27: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 00:27: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 00:27: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 00:27: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 00:27: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 00:27: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 00:27:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:27:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:27:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:27: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 00:27: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 00:27: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 00:27: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 00:27: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 00:27: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 00:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:27:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:27:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:27:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:27:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:27:29 INFO - no previously-included directories found matching 'docs/_build' 00:27:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:27:29 INFO - Running setup.py install for pep8 00:27:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:27:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:27:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:27:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:27:29 INFO - no previously-included directories found matching 'docs/_build' 00:27:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:27:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:27:29 INFO - Cleaning up... 00:27:29 INFO - Return code: 0 00:27:29 INFO - Running post-action listener: _resource_record_post_action 00:27:29 INFO - Running post-action listener: _start_resource_monitoring 00:27:29 INFO - Starting resource monitoring. 00:27:29 INFO - ##### 00:27:29 INFO - ##### Running install step. 00:27:29 INFO - ##### 00:27:29 INFO - Running pre-action listener: _resource_record_pre_action 00:27:30 INFO - Running main action method: install 00:27:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:27:30 INFO - Reading from file tmpfile_stdout 00:27:30 INFO - Detecting whether we're running mozinstall >=1.0... 00:27:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:27:30 INFO - Reading from file tmpfile_stdout 00:27:30 INFO - Output received: 00:27:30 INFO - Usage: mozinstall [options] installer 00:27:30 INFO - Options: 00:27:30 INFO - -h, --help show this help message and exit 00:27:30 INFO - -d DEST, --destination=DEST 00:27:30 INFO - Directory to install application into. [default: 00:27:30 INFO - "/builds/slave/test"] 00:27:30 INFO - --app=APP Application being installed. [default: firefox] 00:27:30 INFO - mkdir: /builds/slave/test/build/application 00:27:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:28:04 INFO - Reading from file tmpfile_stdout 00:28:04 INFO - Output received: 00:28:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:28:04 INFO - Running post-action listener: _resource_record_post_action 00:28:04 INFO - ##### 00:28:04 INFO - ##### Running run-tests step. 00:28:04 INFO - ##### 00:28:04 INFO - Running pre-action listener: _resource_record_pre_action 00:28:04 INFO - Running main action method: run_tests 00:28:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:28:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:28:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:28:04 INFO - 2016-02-10 00:28:04.455 screenresolution[1665:10491] starting screenresolution argv=screenresolution get 00:28:04 INFO - 2016-02-10 00:28:04.458 screenresolution[1665:10491] Display 0: 1600x1200x32@60 00:28:04 INFO - 2016-02-10 00:28:04.464 screenresolution[1666:10493] starting screenresolution argv=screenresolution list 00:28:04 INFO - Available Modes on Display 0 00:28:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:28:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:28:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:28:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:28:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:28:04 INFO - Intel Iris: 00:28:04 INFO - Chipset Model: Intel Iris 00:28:04 INFO - Type: GPU 00:28:04 INFO - Bus: Built-In 00:28:04 INFO - VRAM (Dynamic, Max): 1536 MB 00:28:04 INFO - Vendor: Intel (0x8086) 00:28:04 INFO - Device ID: 0x0a2e 00:28:04 INFO - Revision ID: 0x0009 00:28:04 INFO - Displays: 00:28:04 INFO - Display: 00:28:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:28:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:28:04 INFO - Display Serial Number: 1600x1200 60 00:28:04 INFO - Main Display: Yes 00:28:04 INFO - Mirror: Off 00:28:04 INFO - Online: Yes 00:28:04 INFO - Rotation: Supported 00:28:04 INFO - Return code: 0 00:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:28:04 INFO - Python 2.7.3 00:28:04 INFO - Return code: 0 00:28:04 INFO - grabbing minidump binary from tooltool 00:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f1d30>, '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 0x10f515db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:28:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:28:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 00:28:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:28:04 INFO - Return code: 0 00:28:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:28:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:28:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:28:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:28:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:28:06 INFO - Return code: 0 00:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:28:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMolHtZHlK/Render', 00:28:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:28:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:28:06 INFO - 'HOME': '/Users/cltbld', 00:28:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:28:06 INFO - 'LOGNAME': 'cltbld', 00:28:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:28:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:06 INFO - 'MOZ_NO_REMOTE': '1', 00:28:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:28:06 INFO - 'NO_EM_RESTART': '1', 00:28:06 INFO - 'PAGER': '/bin/cat', 00:28:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:06 INFO - 'PWD': '/builds/slave/test', 00:28:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:28:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:28:06 INFO - 'SHELL': '/bin/bash', 00:28:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9mNMMSvwy/Listeners', 00:28:06 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 00:28:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:28:06 INFO - 'USER': 'cltbld', 00:28:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:28:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:06 INFO - 'XPC_FLAGS': '0x0', 00:28:06 INFO - 'XPC_SERVICE_NAME': '0', 00:28:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:28:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:28:06 INFO - mozversion application_buildid: 20160209233523 00:28:06 INFO - mozversion application_changeset: 9fd143cd5996c85e8698bdc21ed78472085f699b 00:28:06 INFO - mozversion application_display_name: Nightly 00:28:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:28:06 INFO - mozversion application_name: Firefox 00:28:06 INFO - mozversion application_remotingname: firefox 00:28:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:28:06 INFO - mozversion application_vendor: Mozilla 00:28:06 INFO - mozversion application_version: 47.0a1 00:28:06 INFO - mozversion platform_buildid: 20160209233523 00:28:06 INFO - mozversion platform_changeset: 9fd143cd5996c85e8698bdc21ed78472085f699b 00:28:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:28:06 INFO - mozversion platform_version: 47.0a1 00:28:06 INFO - using testdate: 1455092886 00:28:06 INFO - actual date: 1455092886 00:28:06 INFO - starting webserver on 'localhost:49274' 00:28:06 INFO - SUITE-START | Running 2 tests 00:28:06 INFO - TEST-START | dromaeo_css 00:28:06 INFO - operating with platform_type : mac_ 00:28:06 INFO - Initialising browser for dromaeo_css test... 00:28:06 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpwGKN_I/profile http://localhost:49274/getInfo.html) 00:28:08 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 00:28:08 INFO - PROCESS | 1684 | colorDepth:24 00:28:08 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 00:28:08 INFO - PROCESS | 1684 | __metrics 00:28:09 INFO - PROCESS | 1684 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:28:09 INFO - PROCESS | 1684 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:28:09 INFO - TEST-INFO | 1684: exit 0 00:28:09 INFO - Browser initialized. 00:28:09 INFO - Running cycle 1/1 for dromaeo_css test... 00:28:09 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpwGKN_I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:28:21 INFO - PROCESS | 1688 | RSS: Main: 245956608 00:28:21 INFO - PROCESS | 1688 | 00:29:12 INFO - PROCESS | 1688 | 1455092952344 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] 00:31:22 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 00:31:24 INFO - PROCESS | 1688 | RSS: Main: 363515904 00:31:24 INFO - PROCESS | 1688 | 00:34:26 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 00:34:27 INFO - PROCESS | 1688 | RSS: Main: 380792832 00:34:27 INFO - PROCESS | 1688 | 00:37:29 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 00:37:30 INFO - PROCESS | 1688 | RSS: Main: 381218816 00:37:30 INFO - PROCESS | 1688 | 00:40:32 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 00:40:32 INFO - PROCESS | 1688 | RSS: Main: 374427648 00:40:32 INFO - PROCESS | 1688 | 00:43:36 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 00:43:36 INFO - PROCESS | 1688 | RSS: Main: 346505216 00:43:36 INFO - PROCESS | 1688 | 00:46:39 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 00:46:39 INFO - PROCESS | 1688 | RSS: Main: 485769216 00:46:39 INFO - PROCESS | 1688 | 00:46:39 INFO - PROCESS | 1688 | __start_tp_report 00:46:39 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 00:46:39 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 00:46:39 INFO - PROCESS | 1688 | |i|pagename|runs| 00:46:39 INFO - PROCESS | 1688 | |0;dojo.html;3476.7700327940765;3477.930441391172;3500.1774582973;3541.62812904645;3580.0154957386717;5592.384837667863;5647.3505546862025;5685.3461851887;5692.316921969365;5704.800331988381;5665.433456654332;5669.8582535436635;5739.713014349276;5806.680632565207;5812.622179558326;5089.567386772129;5124.000819840124;5134.0758663440565;5148.407933087706;5219.504147106038;5201.2458193561915;5258.50044245796;5265.8946821063555;5273.209018647195;5313.070212712779;5109.412417571953;5120.718360490153;5186.170212765977;5199.402068762065;5236.92144617831;5141.614378921596;5185.325907632021;5195.428502864682;5212.713300768456;5218.504242096995;5101.260317254015;5147.562457191143;5171.715555644438;5180.792768289264;5191.766370513298;5438.53772429344;5574.024545704526;5596.2165296858475;5634.971825140848;5637.379888212294;6108.96945515274;6144.201253837017;6151.415615516519;6153.138560601519;6172.629642221436;6141.232345956755;6143.569950103494;6168.629882207082;6182.598131121463;6237.656928868911;4846.491118432585;5661.830145095612;5780.855478613068;5810.215620891167;5818.883622327529;6247.843803904939;6252.499800016079;6259.906101408483;6270.6864656766975;6271.05934109878;6073.18012068374;6077.179580756541;6112.877742445126;6123.785667501616;6135.509159267248;6110.419510146529;6129.695011270001;6149.292831324455;6210.130581718563;6239.844003899848;6148.354422785543;6152.323244443108;6164.599301045418;6168.352323006109;6175.289841668266;6199.3490683477585;6201;6202.596831205957;6207.441330280297;6221.688915554204;3833.8083095845095;4796.952030479651;4838.830640927551;4841.05599408112;4852.490488498657;4368.36658684489;4382.430284063115;4410.647148228134;4436.3567282743825;4474.910501789946;5684.426965843528;5710.457506536873;5730.34101078373;5742.827715168552;5754.079347304411;6264.718087686065;6266.561340706198;6273.466755325849;6280;6283.748650054038;5557.861053473695;5695.974724549538;5696.629719068247;5766.654000759968;5805.970970145207;5320.228566857784;5333.546648534918;5344.278522399426;5351.3578370595;5354.303940487712;6187.474064704551;6287.685615719196;6299.937000629935;6304.747810087545;6312.747490100436;6118.954222337191;6176.567640265138;6262.906056409066;6272.372762723691;6278.246610406781;6266.655333956676;6273.780417685359;6275.497960163268;6291.339409361951;6308.968455157695;6015.947209238278;6142.385761423822;6165.599236049642;6171.043488259327;6183.319834818257;6137.070562331885;6228.0969259456215;6234;6242.282137554058;6243.656598887105;5977.432143946318;5989.520838332835;5998.580099393175;6020.397960203944;6058.0610005449225;5779.913301300568;5850.297964244148;6008.339082700812;6010.789622363196;6019.307779605401;5920.200772895776;5920.585559010828;5927;5951.821445356646;5955.940440595712;6037.245344331958;6060.969695151673;6114.315000671675;6116.670564642638;6123.060032935882;5793.623414478046;5867.970660146672;5890.7349169288345;5963.493103086286;5970.820875373745 00:46:39 INFO - PROCESS | 1688 | |1;ext.html;433.85682724700854;438.3337327262561;486.09586169724327;495.9708604645362;561.8930706508179;29360.853195734016;29739.702602973965;29805.701942980562;29877.80488780449;29984;34947.252637368154;35625.109372265644;38138.4279235811;38792.22415551687;38867.805660971724;7827.139014708392;9389.295802814782;9395.953020234923;9412.152906238438;9415.95292023539;9534.856977145348;9681;9688.951555242214;9691.757706057335;9697.612095516206;9635.518224088803;9696.70909872705;9709.75725606862;9711.75720606987;9713;8429.70496032639;9705.223582113449;9722.270829687732;9802.75493112678;9803.411795292306;8683.739487815375;9682.56428460721;9831.606735730562;9851.45816980073;9858.16205622523;39175.41236881449;39519.4072088916;39533.20933581341;39604.40593391102;39616.40575391342;3440.397930362202;3630.7640003399692;3735.813209339522;3748.175401411685;3970.463987361698;27798.583021254697;28556.571651425245;28705.28236794076;28765.280867978257;29510;2705.742954419327;2782.8608569571643;2787.512185367553;2963.940721185586;2983.9104826855228;466835;467952;468820;470178;471333.99999999657;53053.46946530562;54253.91492170213;62059;63244.68377658082;63274.68362658157;59382;59617;59883;59889;59953;15799.763003554956;15949.20253987296;15989.680206395808;16008.599785005235;16026.839731602768;10223.693289201336;10543.156547476183;12107.576234831915;12685.365731713377;12688.365581721062;19018;19054.714179287323;19064.33274835374;19066.713999290023;19095.80904190968;7247.528910620793;8565;8763.386562940661;8772.912270877338;8898.777530561787;948.2271948362201;980.2109302011949;987.6543209876486;1011.1657882247175;1079.2499213047015;28775.424491510472;29337.332833395827;29578.556321655193;29739;29832.552511712343;1044.4151275285865;1072.3887384190937;1088.1175566270397;1097.6268068856627;1131.1562153689433;11702.648920532398;14070.226137562327;14163;14168.716625667636;14300.785488217685;520995;528515;528698;530684;531007;53992.460075399526;54370.91258174893;54460.91078178414;54589;54647.726761365935;1398.4196558428139;1405.0726520496423;1432.9928350358182;1433.6702558411623;1436.095259986202;26914;26990.73009269882;27533.586996195474;27650.5852412218;27965;37248.44127338146;46155.307670384296;46258;46288.84277892945;46419;486115;493031;530405;539434;540808;29109.69006394675;29259.7074029257;29339.119826405244;29417.11748647544;29530.261743455725;40474.78575642735;40696.59303406928;40730.38904416377;40759.59240407558;41145.58854411537;34404;35280.588776448654;35299.470507941885;35412.64587354093;35574;33775.83112084424;34463.96608101761;34527.82736086303;34624.307513850086;34715;33149;33911.83044084764;34189.97430077101;34198.82900585481;34238.14404639904;29195.85402072976;29455.96904108346;30529.847350763994;30547;30592.235194120323;23736.14301408197;23936;23955.640665389685;24301.51396972086;24466.085426332414 00:46:39 INFO - PROCESS | 1688 | |2;jquery.html;319.3134760265429;370.92581483703265;372.98508059677613;375.9304528662196;376.4936160863638;14871.553853384388;15130.243487825592;18695.3456629018;19713.21147154114;20186.697199542017;18496.98266595337;18618.34835780748;19290.03549822507;19296.807031929675;19326.903365483155;5587.720613969295;5751.281089863767;5811.186433899257;5812.331581868097;5814.186013958049;4133.607307305816;4344.804483798237;5688.63023903447;5755.625884317506;6041.667708276043;6015.127806468059;6194.163787888622;6271.466925311354;6271.749130034793;6275.6548389838545;6239.625622462667;6239.875202495948;6240;6240.188775459184;6249.343818899041;5223.451537588575;5311.389190243133;5340.412554618989;5372.382176049765;5375.973120134413;23350.64974025391;24036;24172.758272417228;24222.152224672052;24398.512029759306;2246.539459410817;2258.954820903573;2392.0192720984487;2524.9269060649335;2558.769710726025;13869.514566990107;14403.78394324086;14563.563093107117;14814.925925370411;14964.102153870803;1585.715570387978;1687.392538686072;1747.2104197275946;1805.142557285292;1836.182898610119;91311;94387;95404.56893146608;97007.02992970121;97797.51101244448;10407.94796026015;11178.27341222818;11196.216264861545;11228.101751859831;11296.587926509186;11090.944545277222;13378.665533361744;13467.730645387037;13496;13500.5274815381;8364.832703345899;8483.194096560817;8501.404901656824;8563.357748168912;8573.528455934984;6902.792916212522;8570.614322355508;8582.527960962207;8643.481391116427;8669.826603467895;4036.7577945323374;4365.257906155961;4440.511543730187;4476.798544065525;4488.3940668010055;1665.5086749408954;1732.341710150135;1748.4404990403202;1750.5798608334162;1850.9259629614935;752.39808153477;975.4977334904169;985.8373368394134;986.6004268271362;991.0733464210986;14534.927325363305;16666.50000499987;18801.90599046996;19657.901710491355;19905.701414478794;883.7923088074298;962.7544976031207;966.1980556138528;976.3507267667064;1035.8601588785568;8273.46222495536;9413.529323533796;9830.21358291335;9861;9928.751781205528;528389;532610;539324;597953;660822;71187;82177;115817;117912.41043794726;118869.40565297118;1033.204432586904;1154.7344110854551;1171.3323405658693;1190.922590031645;1196.5632544121333;17605.119744013005;17910;17924.283028678707;17975.820241797413;18226.45320640383;49040.75479622579;50495.49504504908;51201.13589209019;51631.74184129205;51717.44847654577;71937;72241;72465.6376718113;72965.79790717635;73185.53628927498;7234.529755565872;7389.815254618463;7398.889016664647;7460.179380268058;7557.848843023219;7892.921070789219;9015.684451044444;9460.337776355864;10911.945440272748;11755.529778808752;9700.708978730649;9978;10203.489825508546;10277.9486102569;10496.370217786956;7267.890981635174;9608.183304419203;9625;10241.590336386462;10391.636292729718;9757.853632195665;10181.33821301613;10418.270721049454;10501.369917804956;10838.783224335311;7482.139553951365;7672.8849067265155;7676.577788221702;7677.539347639159;7685.385169186564;10121;10486.26596138263;10736.89263107359;10764.3541387517;10768.030877221088 00:46:39 INFO - PROCESS | 1688 | |3;mootools.html;1357.8913686905046;1385.4527461652654;1568.4196847166547;1765.170369926135;1962.5584243545204;7964.601769911503;8571.185737354957;8705.998810136836;8712.782180445483;8715.25920296774;8355.83288334233;8634.352423568225;8636.91363086369;8637.956810215941;8677.783055423617;2178.346496051186;2236.563870045342;2443.51129774045;2469.666595009673;2476.4923190745944;2469.71598266199;2507.8746062696882;2517.6223566465087;2517.773400393964;2518.609615509599;2469.1358024691303;2498.8250822442437;2503.399184195798;2505.2734706934966;2506.3358210074343;2410.6384042393693;2472.2336075816374;2475.2450502596703;2484.63972723954;2484.776370126697;2432.0636554926305;2464.667269918556;2477.306354220821;2480.8139389545854;2483.242611003643;8693.521856297964;8757.168069033432;8780.64877404903;8787.384883058188;8806.955965220197;4782.258749893772;5239.502247286539;5290.629655924087;5486.643368181095;5489.011977843987;3546.9891081042038;3589.73077019222;3645.216278500135;3668.284684486526;3670.119171398872;1039.8752149742004;1040.531760707677;1047.4553232319151;1096.5230124895616;1102.3055475050667;11856.762864742743;11875.52497900083;11879.465424055852;11881.702957426047;11887.465064072137;4874.561289483963;4888.975555122272;4945.826896058621;4977.427595826454;4980.402351717817;10222.64220752285;10240.64157754475;10246.846297305547;10251.026152515498;10255.897441025643;5480.780768769284;5506.063969125178;5511.4213007633625;5515.751791169407;5518.586106042063;4950.455449900508;5017.046761115376;5019.14674505335;5025.221090730943;5032.194848824244;3935.134270460494;3969.563348031714;3986.60133986599;4012.257732319472;4028.234635419261;1302.6873550348039;1303.0878385130447;1303.2506308872437;1304.4130141436392;1330.8003799430162;1299.0906365544156;1299.7660421124099;1315.9144655597356;1353.282760137129;1355.302019459979;8157.510549366938;8158.469699469515;8171;8188.099309075997;8198.098209196984;448.9416375871116;473.61637073970195;485.97813098410654;489.21236808737905;516.7855340033843;6176.690418057629;6204.410580994799;6247.344028876993;6248.250209974741;6255.718492667841;10386.221033422524;10773.730656733644;10785.946070269598;10871.021608055313;10874.18443616732;10422.21833362501;10609.939006099328;10745.301555398873;10759.515821788038;10773.138148948065;8101;8191.303739182236;8202.917970820215;8303.709370172015;8311.625976831057;7677.577733224726;7844.921550784419;7852.803679908048;7861.52830830152;7880.960595196987;9178.770530736785;9452.196563292197;9572.042795720372;9709.805803884024;9715.902840971783;9244.168024877794;9538.23694104456;9591.040895910353;10004.049615286536;10026;6568.6058836469965;6779.525433219627;7147.499675022698;7372;7416.369608583331;8120.75637730869;8158.796030099295;8188;8191.017077950684;8226.30076443509;7423.294786995443;7683.807904802425;7689.807754806175;7794.947682063076;7819.41354398411;7446.70213191488;7580.469367144247;7598.316151546387;7658;7697.076350837935;7671.8849217262905;7700.037495313086;7758.224177582197;7761.456698031309;7770.339521140766;7028.964855175692;7082.5396349237135;7086.787396378117;7097.325754053357;7102.9289707104335;7163.570185788869;7206.387457066208;7231.63841807897;7240;7240.239774823778 00:46:39 INFO - PROCESS | 1688 | |4;prototype.html;320.87325506424963;326.99019029429127;331.3604742846306;333.07405412951994;335.7280602711802;6472.935270647292;6608.2730899601065;6622.139121914151;6631.137952066237;6669.999500074979;6565.6060636361735;6577.473802095833;6584;6600.933990660092;6601.240857301412;3948.585398533163;4789.688670236441;4856.417229932413;4862.610991120702;4863.610911127119;4878.02439512099;4878.48775878533;4880.3655524781725;4882.926756098661;4900.460949295592;4603.723776573416;4637.9072418551605;4698.788554515055;4773.403324584427;4839.4918533554;4705.223638099709;4779.498152693969;4784.067106914154;4789.185838407444;4813.205821039524;4039.979800100981;4083.775392353419;4086.4074709167303;4095.7337773044655;4101.138760860223;6257.155284036642;6295.2760432550385;6307.9684601577155;6332.810015699491;6337.651429171394;4625.699329543569;5488.290663020925;5559.942031882449;5626.549876009909;5631.324241091054;5695.943040569583;6459.837229298724;6997.335253150994;6998.545094568837;7007.82480437988;4070.5115386153852;4329.740215587075;4532.229520981441;4534.88662783433;4555.453345598549;6227.906581401283;7251;7436.851262974765;7445.404367650575;7460.104787425544;4598.540145985375;4610.53894610543;4625.167469855391;4633.907321853544;4639.512851150648;3996.540397854284;4593.908121837611;4690.15577196108;4694.929576056362;4712.9057418851435;5397.8110766123;5415.6479828811;5567.888642227133;5604;5606.747696353674;6046.969765151146;6384.457321127663;6467.579607325509;7049.823754406181;7096.148462184571;1601.5355546891271;1625.07370798646;1627.9267432965546;1630.3315640587539;1631.5431679129863;1028.4651980969854;1039.3971496531992;1050.894910508943;1051.0645525482328;1067.8398240264023;5856.502197313191;6287.622742635456;6640.335966403321;6667.766628168088;6675.79972600813;7298.927010729931;7318.926810731825;7324.96337518309;7335.166208447888;7342.559446433231;6403;6634.933650663528;6637.502187335969;6668.833279167962;6669.566478178903;3814.1418180909072;3835.463035175078;3841.154945911895;3846.480725102131;3849.0177558557366;6082.452579267799;6088.634681919099;7515.173330933593;7531.585762783099;7560.810979725441;7296.16094149169;7375.4099672026105;7382.409407247407;7384.852302953911;7573.697052117964;6232.657203853832;6295.716692748837;7015.421530155674;7799.181085986003;7821.726239581587;7416.110066791804;7429.294217049372;7434.553926764412;7449.44129190302;7461.589612571143;6989.301069893173;7056.682449289691;7136;7197.496175267681;7344.853102938018;7760.417968652261;7799.259070388304;7803.336716378944;7811.570363629828;7821;4617.445906491243;4665.486796452456;4667.509911459248;4680.695754775928;4689.507601701908;6469.061986011908;6673.766418175341;7365.1530074042175;7391.556506609406;7395.889061663972;7105.50261481712;7112.786616401516;7118.145822501126;7121.216666166614;7125.394341481032;6897.48268879826;7111.111111111111;7121.359077683033;7127.501074924706;7146.714131434893;5636;5665.461781130786;6281.371862813865;6368.395002474757;6944.861102777815;7086.326798954091;7092.503524753218;7119.466040046914;7124.465665075244;7126.109236345457;5698.772049117989;6773.05177275172;6949.7567585134275;6953.235144134243;6954.930450695429 00:46:39 INFO - PROCESS | 1688 | |5;yui.html;639.5171645407719;665.6738198282843;673.6968364236094;680.6290571638457;748.147112291987;12760.617181484558;14863.10821350717;15114;15118.773218401719;15119.244037798107;14343.13941163531;14419.639509012253;14423.567292981228;14429.278536073181;14452.566423007327;686.601770972837;700.3381804195038;839.8026463781007;846.6571038729325;860.2945584620613;714.4106112457217;849.3969281809923;861.2291998661194;863.0204717645486;863.9006514250879;912.6668765900465;913.5477938420491;914.6250037484633;915.0712027292303;917.3578495053456;672.37133280383;685.0717278088218;715.706560310273;729.9854002919965;734.0787311923555;660.6069388713707;672.515788632184;676.4892506157869;676.8307923019245;677.3226773226774;14837.406503739838;14860.182689952047;14876.181810000446;14894.553163405115;14906.627334316621;12162.756744865143;12269;12335.321557314344;12636;12741.299228542426;9694.854577181348;9820.803583928353;9852.064053914866;9890.80218395628;10012.29913906027;2931.4723349797027;3491.162121090945;3513.367593833109;3536.7701099428455;3662.505561749156;76559;78315.6084219581;78319.60840195819;78457.60771196107;78506;9249.956349305385;9346.222158098673;9454.05459454049;9465.952670236606;9471.952640236756;20992.221400147813;21174.87090017432;21182.15271389158;21200.681989770164;21208.15167393287;7158.964205178941;7268.781936541912;7434.3309102181065;7443.8883416748795;7496.287852654098;3992.8802135935966;4034.4755181826763;4082.387641853686;4107.199096176217;4259.169461954889;3370.831458427069;3427.0232983599553;3428.6571342865514;3431.742619303562;3435.158386195398;620.6121174266084;627.9215098112736;632.8987362022054;635.3392471829246;640.810960766575;513.5070332480785;528.7831988884539;573.5669569475019;583.4311546242379;604.5103466192311;8534;8540.103289154673;8555.572221388906;8806.075362087016;8823.470591764386;489.6890474548616;511.98464046078675;548.4916479680877;603.6679826095717;606.6511755740379;3729.4965179700935;3784.8864534064023;4075.694322925792;4086.244044851712;4230.323148296319;66535.66732166309;67353.98969015469;85981;93726.53136734273;95131.43817056499;77164;77582;78032.21967780363;78544;79141.81287280696;70360.64819675869;72507.91238131432;73046.63476682689;73598.26401735914;74015.25984740084;8693.826123477622;8704;8791.208791208823;8844.380893337404;9143.759778854223;46941.765291173324;47357;48280.7585962068;48503.787405315146;50394.244086339466;63129.737405252556;63719.044214335896;64574.35425645871;65348.01977970429;65986.01020984785;11259.211855170059;11326.32042077478;11599.188056835941;11634.592789252336;11735.706607334885;10196.796064078826;12009.879901200877;12387.62837114888;12418.813717794059;12530.624081277576;10683.5192416343;10911.672649820519;10936.015758581765;11254.38100904458;11704.94147529257;11222.607208747655;11288.548458061585;11302.547898083985;11417.885821141683;12355.505779769068;8330.637915543575;10138.898611013796;10451.529681164518;11411.714707132389;11502.53989840397;8893.777655558662;9282.489463079595;9293.163615274387;9477.668281610111;9544.522773861418;7476.962615186889;9094.022864120761;9179.954100229455;9386.296027797805;9503.429794212369 00:46:39 INFO - PROCESS | 1688 | __end_tp_report 00:46:39 INFO - PROCESS | 1688 | __start_cc_report 00:46:39 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,1071 00:46:39 INFO - PROCESS | 1688 | __end_cc_report 00:46:39 INFO - PROCESS | 1688 | __startTimestamp1455093999938__endTimestamp 00:46:39 INFO - PROCESS | 1688 | 00:46:39 INFO - PROCESS | 1688 | ------- Summary: start ------- 00:46:39 INFO - PROCESS | 1688 | Number of tests: 6 00:46:39 INFO - PROCESS | 1688 | 00:46:39 INFO - PROCESS | 1688 | [#0] dojo.html Cycles:165 Average:5706.60 Median:5927.00 stddev:632.96 (10.7%) stddev-sans-first:610.25 00:46:39 INFO - PROCESS | 1688 | Values: 3476.8 3477.9 3500.2 3541.6 3580.0 5592.4 5647.4 5685.3 5692.3 5704.8 5665.4 5669.9 5739.7 5806.7 5812.6 5089.6 5124.0 5134.1 5148.4 5219.5 5201.2 5258.5 5265.9 5273.2 5313.1 5109.4 5120.7 5186.2 5199.4 5236.9 5141.6 5185.3 5195.4 5212.7 5218.5 5101.3 5147.6 5171.7 5180.8 5191.8 5438.5 5574.0 5596.2 5635.0 5637.4 6109.0 6144.2 6151.4 6153.1 6172.6 6141.2 6143.6 6168.6 6182.6 6237.7 4846.5 5661.8 5780.9 5810.2 5818.9 6247.8 6252.5 6259.9 6270.7 6271.1 6073.2 6077.2 6112.9 6123.8 6135.5 6110.4 6129.7 6149.3 6210.1 6239.8 6148.4 6152.3 6164.6 6168.4 6175.3 6199.3 6201.0 6202.6 6207.4 6221.7 3833.8 4797.0 4838.8 4841.1 4852.5 4368.4 4382.4 4410.6 4436.4 4474.9 5684.4 5710.5 5730.3 5742.8 5754.1 6264.7 6266.6 6273.5 6280.0 6283.7 5557.9 5696.0 5696.6 5766.7 5806.0 5320.2 5333.5 5344.3 5351.4 5354.3 6187.5 6287.7 6299.9 6304.7 6312.7 6119.0 6176.6 6262.9 6272.4 6278.2 6266.7 6273.8 6275.5 6291.3 6309.0 6015.9 6142.4 6165.6 6171.0 6183.3 6137.1 6228.1 6234.0 6242.3 6243.7 5977.4 5989.5 5998.6 6020.4 6058.1 5779.9 5850.3 6008.3 6010.8 6019.3 5920.2 5920.6 5927.0 5951.8 5955.9 6037.2 6061.0 6114.3 6116.7 6123.1 5793.6 5868.0 5890.7 5963.5 5970.8 00:46:39 INFO - PROCESS | 1688 | 00:46:39 INFO - PROCESS | 1688 | [#1] ext.html Cycles:180 Average:63318.31 Median:20439.60 stddev:134814.50 (659.6%) stddev-sans-first:135110.02 00:46:39 INFO - PROCESS | 1688 | Values: 433.9 438.3 486.1 496.0 561.9 29360.9 29739.7 29805.7 29877.8 29984.0 34947.3 35625.1 38138.4 38792.2 38867.8 7827.1 9389.3 9396.0 9412.2 9416.0 9534.9 9681.0 9689.0 9691.8 9697.6 9635.5 9696.7 9709.8 9711.8 9713.0 8429.7 9705.2 9722.3 9802.8 9803.4 8683.7 9682.6 9831.6 9851.5 9858.2 39175.4 39519.4 39533.2 39604.4 39616.4 3440.4 3630.8 3735.8 3748.2 3970.5 27798.6 28556.6 28705.3 28765.3 29510.0 2705.7 2782.9 2787.5 2963.9 2983.9 466835.0 467952.0 468820.0 470178.0 471334.0 53053.5 54253.9 62059.0 63244.7 63274.7 59382.0 59617.0 59883.0 59889.0 59953.0 15799.8 15949.2 15989.7 16008.6 16026.8 10223.7 10543.2 12107.6 12685.4 12688.4 19018.0 19054.7 19064.3 19066.7 19095.8 7247.5 8565.0 8763.4 8772.9 8898.8 948.2 980.2 987.7 1011.2 1079.2 28775.4 29337.3 29578.6 29739.0 29832.6 1044.4 1072.4 1088.1 1097.6 1131.2 11702.6 14070.2 14163.0 14168.7 14300.8 520995.0 528515.0 528698.0 530684.0 531007.0 53992.5 54370.9 54460.9 54589.0 54647.7 1398.4 1405.1 1433.0 1433.7 1436.1 26914.0 26990.7 27533.6 27650.6 27965.0 37248.4 46155.3 46258.0 46288.8 46419.0 486115.0 493031.0 530405.0 539434.0 540808.0 29109.7 29259.7 29339.1 29417.1 29530.3 40474.8 40696.6 40730.4 40759.6 41145.6 34404.0 35280.6 35299.5 35412.6 35574.0 33775.8 34464.0 34527.8 34624.3 34715.0 33149.0 33911.8 34190.0 34198.8 34238.1 29195.9 29456.0 30529.8 30547.0 30592.2 23736.1 23936.0 23955.6 24301.5 24466.1 00:46:39 INFO - PROCESS | 1688 | 00:46:39 INFO - PROCESS | 1688 | [#2] jquery.html Cycles:180 Average:32241.11 Median:4482.60 stddev:95015.76 (2119.7%) stddev-sans-first:95252.07 00:46:39 INFO - PROCESS | 1688 | Values: 319.3 370.9 373.0 375.9 376.5 14871.6 15130.2 18695.3 19713.2 20186.7 18497.0 18618.3 19290.0 19296.8 19326.9 5587.7 5751.3 5811.2 5812.3 5814.2 4133.6 4344.8 5688.6 5755.6 6041.7 6015.1 6194.2 6271.5 6271.7 6275.7 6239.6 6239.9 6240.0 6240.2 6249.3 5223.5 5311.4 5340.4 5372.4 5376.0 23350.6 24036.0 24172.8 24222.2 24398.5 2246.5 2259.0 2392.0 2524.9 2558.8 13869.5 14403.8 14563.6 14814.9 14964.1 1585.7 1687.4 1747.2 1805.1 1836.2 91311.0 94387.0 95404.6 97007.0 97797.5 10407.9 11178.3 11196.2 11228.1 11296.6 11090.9 13378.7 13467.7 13496.0 13500.5 8364.8 8483.2 8501.4 8563.4 8573.5 6902.8 8570.6 8582.5 8643.5 8669.8 4036.8 4365.3 4440.5 4476.8 4488.4 1665.5 1732.3 1748.4 1750.6 1850.9 752.4 975.5 985.8 986.6 991.1 14534.9 16666.5 18801.9 19657.9 19905.7 883.8 962.8 966.2 976.4 1035.9 8273.5 9413.5 9830.2 9861.0 9928.8 528389.0 532610.0 539324.0 597953.0 660822.0 71187.0 82177.0 115817.0 117912.4 118869.4 1033.2 1154.7 1171.3 1190.9 1196.6 17605.1 17910.0 17924.3 17975.8 18226.5 49040.8 50495.5 51201.1 51631.7 51717.4 71937.0 72241.0 72465.6 72965.8 73185.5 7234.5 7389.8 7398.9 7460.2 7557.8 7892.9 9015.7 9460.3 10911.9 11755.5 9700.7 9978.0 10203.5 10277.9 10496.4 7267.9 9608.2 9625.0 10241.6 10391.6 9757.9 10181.3 10418.3 10501.4 10838.8 7482.1 7672.9 7676.6 7677.5 7685.4 10121.0 10486.3 10736.9 10764.4 10768.0 00:46:39 INFO - PROCESS | 1688 | 00:46:39 INFO - PROCESS | 1688 | [#3] mootools.html Cycles:180 Average:6055.69 Median:5028.71 stddev:3202.26 (63.7%) stddev-sans-first:3191.77 00:46:39 INFO - PROCESS | 1688 | Values: 1357.9 1385.5 1568.4 1765.2 1962.6 7964.6 8571.2 8706.0 8712.8 8715.3 8355.8 8634.4 8636.9 8638.0 8677.8 2178.3 2236.6 2443.5 2469.7 2476.5 2469.7 2507.9 2517.6 2517.8 2518.6 2469.1 2498.8 2503.4 2505.3 2506.3 2410.6 2472.2 2475.2 2484.6 2484.8 2432.1 2464.7 2477.3 2480.8 2483.2 8693.5 8757.2 8780.6 8787.4 8807.0 4782.3 5239.5 5290.6 5486.6 5489.0 3547.0 3589.7 3645.2 3668.3 3670.1 1039.9 1040.5 1047.5 1096.5 1102.3 11856.8 11875.5 11879.5 11881.7 11887.5 4874.6 4889.0 4945.8 4977.4 4980.4 10222.6 10240.6 10246.8 10251.0 10255.9 5480.8 5506.1 5511.4 5515.8 5518.6 4950.5 5017.0 5019.1 5025.2 5032.2 3935.1 3969.6 3986.6 4012.3 4028.2 1302.7 1303.1 1303.3 1304.4 1330.8 1299.1 1299.8 1315.9 1353.3 1355.3 8157.5 8158.5 8171.0 8188.1 8198.1 448.9 473.6 486.0 489.2 516.8 6176.7 6204.4 6247.3 6248.3 6255.7 10386.2 10773.7 10785.9 10871.0 10874.2 10422.2 10609.9 10745.3 10759.5 10773.1 8101.0 8191.3 8202.9 8303.7 8311.6 7677.6 7844.9 7852.8 7861.5 7881.0 9178.8 9452.2 9572.0 9709.8 9715.9 9244.2 9538.2 9591.0 10004.0 10026.0 6568.6 6779.5 7147.5 7372.0 7416.4 8120.8 8158.8 8188.0 8191.0 8226.3 7423.3 7683.8 7689.8 7794.9 7819.4 7446.7 7580.5 7598.3 7658.0 7697.1 7671.9 7700.0 7758.2 7761.5 7770.3 7029.0 7082.5 7086.8 7097.3 7102.9 7163.6 7206.4 7231.6 7240.0 7240.2 00:46:39 INFO - PROCESS | 1688 | 00:46:39 INFO - PROCESS | 1688 | [#4] prototype.html Cycles:180 Average:5675.56 Median:6320.39 stddev:1826.53 (28.9%) stddev-sans-first:1786.89 00:46:39 INFO - PROCESS | 1688 | Values: 320.9 327.0 331.4 333.1 335.7 6472.9 6608.3 6622.1 6631.1 6670.0 6565.6 6577.5 6584.0 6600.9 6601.2 3948.6 4789.7 4856.4 4862.6 4863.6 4878.0 4878.5 4880.4 4882.9 4900.5 4603.7 4637.9 4698.8 4773.4 4839.5 4705.2 4779.5 4784.1 4789.2 4813.2 4040.0 4083.8 4086.4 4095.7 4101.1 6257.2 6295.3 6308.0 6332.8 6337.7 4625.7 5488.3 5559.9 5626.5 5631.3 5695.9 6459.8 6997.3 6998.5 7007.8 4070.5 4329.7 4532.2 4534.9 4555.5 6227.9 7251.0 7436.9 7445.4 7460.1 4598.5 4610.5 4625.2 4633.9 4639.5 3996.5 4593.9 4690.2 4694.9 4712.9 5397.8 5415.6 5567.9 5604.0 5606.7 6047.0 6384.5 6467.6 7049.8 7096.1 1601.5 1625.1 1627.9 1630.3 1631.5 1028.5 1039.4 1050.9 1051.1 1067.8 5856.5 6287.6 6640.3 6667.8 6675.8 7298.9 7318.9 7325.0 7335.2 7342.6 6403.0 6634.9 6637.5 6668.8 6669.6 3814.1 3835.5 3841.2 3846.5 3849.0 6082.5 6088.6 7515.2 7531.6 7560.8 7296.2 7375.4 7382.4 7384.9 7573.7 6232.7 6295.7 7015.4 7799.2 7821.7 7416.1 7429.3 7434.6 7449.4 7461.6 6989.3 7056.7 7136.0 7197.5 7344.9 7760.4 7799.3 7803.3 7811.6 7821.0 4617.4 4665.5 4667.5 4680.7 4689.5 6469.1 6673.8 7365.2 7391.6 7395.9 7105.5 7112.8 7118.1 7121.2 7125.4 6897.5 7111.1 7121.4 7127.5 7146.7 5636.0 5665.5 6281.4 6368.4 6944.9 7086.3 7092.5 7119.5 7124.5 7126.1 5698.8 6773.1 6949.8 6953.2 6954.9 00:46:39 INFO - PROCESS | 1688 | 00:46:39 INFO - PROCESS | 1688 | [#5] yui.html Cycles:180 Average:17802.10 Median:32179.28 stddev:24740.15 (76.9%) stddev-sans-first:24775.99 00:46:39 INFO - PROCESS | 1688 | Values: 639.5 665.7 673.7 680.6 748.1 12760.6 14863.1 15114.0 15118.8 15119.2 14343.1 14419.6 14423.6 14429.3 14452.6 686.6 700.3 839.8 846.7 860.3 714.4 849.4 861.2 863.0 863.9 912.7 913.5 914.6 915.1 917.4 672.4 685.1 715.7 730.0 734.1 660.6 672.5 676.5 676.8 677.3 14837.4 14860.2 14876.2 14894.6 14906.6 12162.8 12269.0 12335.3 12636.0 12741.3 9694.9 9820.8 9852.1 9890.8 10012.3 2931.5 3491.2 3513.4 3536.8 3662.5 76559.0 78315.6 78319.6 78457.6 78506.0 9250.0 9346.2 9454.1 9466.0 9472.0 20992.2 21174.9 21182.2 21200.7 21208.2 7159.0 7268.8 7434.3 7443.9 7496.3 3992.9 4034.5 4082.4 4107.2 4259.2 3370.8 3427.0 3428.7 3431.7 3435.2 620.6 627.9 632.9 635.3 640.8 513.5 528.8 573.6 583.4 604.5 8534.0 8540.1 8555.6 8806.1 8823.5 489.7 512.0 548.5 603.7 606.7 3729.5 3784.9 4075.7 4086.2 4230.3 66535.7 67354.0 85981.0 93726.5 95131.4 77164.0 77582.0 78032.2 78544.0 79141.8 70360.6 72507.9 73046.6 73598.3 74015.3 8693.8 8704.0 8791.2 8844.4 9143.8 46941.8 47357.0 48280.8 48503.8 50394.2 63129.7 63719.0 64574.4 65348.0 65986.0 11259.2 11326.3 11599.2 11634.6 11735.7 10196.8 12009.9 12387.6 12418.8 12530.6 10683.5 10911.7 10936.0 11254.4 11704.9 11222.6 11288.5 11302.5 11417.9 12355.5 8330.6 10138.9 10451.5 11411.7 11502.5 8893.8 9282.5 9293.2 9477.7 9544.5 7477.0 9094.0 9180.0 9386.3 9503.4 00:46:39 INFO - PROCESS | 1688 | -------- Summary: end -------- 00:46:39 INFO - PROCESS | 1688 | 00:46:40 INFO - TEST-INFO | 1688: exit 0 00:46:40 INFO - TEST-OK | dromaeo_css | took 1113865ms 00:46:40 INFO - TEST-START | kraken 00:46:40 INFO - operating with platform_type : mac_ 00:46:40 INFO - Initialising browser for kraken test... 00:46:40 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpsy4dD6/profile http://localhost:49274/getInfo.html) 00:46:42 INFO - PROCESS | 1695 | __metrics Screen width/height:1600/1200 00:46:42 INFO - PROCESS | 1695 | colorDepth:24 00:46:42 INFO - PROCESS | 1695 | Browser inner width/height: 1024/689 00:46:42 INFO - PROCESS | 1695 | __metrics 00:46:42 INFO - PROCESS | 1695 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:46:42 INFO - PROCESS | 1695 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:46:43 INFO - TEST-INFO | 1695: exit 0 00:46:43 INFO - Browser initialized. 00:46:43 INFO - Running cycle 1/1 for kraken test... 00:46:43 INFO - TEST-INFO | started process 1697 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpsy4dD6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:46:55 INFO - PROCESS | 1697 | RSS: Main: 245444608 00:46:55 INFO - PROCESS | 1697 | 00:46:58 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 00:46:58 INFO - PROCESS | 1697 | RSS: Main: 291774464 00:46:58 INFO - PROCESS | 1697 | 00:47:01 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 00:47:01 INFO - PROCESS | 1697 | RSS: Main: 302075904 00:47:01 INFO - PROCESS | 1697 | 00:47:05 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 00:47:05 INFO - PROCESS | 1697 | RSS: Main: 286158848 00:47:05 INFO - PROCESS | 1697 | 00:47:07 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 00:47:08 INFO - PROCESS | 1697 | RSS: Main: 288567296 00:47:08 INFO - PROCESS | 1697 | 00:47:10 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:47:11 INFO - PROCESS | 1697 | RSS: Main: 289050624 00:47:11 INFO - PROCESS | 1697 | 00:47:13 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 00:47:14 INFO - PROCESS | 1697 | RSS: Main: 290541568 00:47:14 INFO - PROCESS | 1697 | 00:47:17 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 00:47:17 INFO - PROCESS | 1697 | RSS: Main: 291782656 00:47:17 INFO - PROCESS | 1697 | 00:47:20 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 00:47:21 INFO - PROCESS | 1697 | RSS: Main: 292319232 00:47:21 INFO - PROCESS | 1697 | 00:47:22 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:47:23 INFO - PROCESS | 1697 | RSS: Main: 326266880 00:47:23 INFO - PROCESS | 1697 | 00:47:25 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:47:25 INFO - PROCESS | 1697 | RSS: Main: 326340608 00:47:25 INFO - PROCESS | 1697 | 00:47:27 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:47:28 INFO - PROCESS | 1697 | RSS: Main: 333758464 00:47:28 INFO - PROCESS | 1697 | 00:47:31 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:47:31 INFO - PROCESS | 1697 | RSS: Main: 334364672 00:47:31 INFO - PROCESS | 1697 | 00:47:34 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:47:34 INFO - PROCESS | 1697 | RSS: Main: 334831616 00:47:34 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 00:47:36 INFO - PROCESS | 1697 | RSS: Main: 395051008 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | __start_tp_report 00:47:36 INFO - PROCESS | 1697 | _x_x_mozilla_page_load 00:47:36 INFO - PROCESS | 1697 | _x_x_mozilla_page_load_details 00:47:36 INFO - PROCESS | 1697 | |i|pagename|runs| 00:47:36 INFO - PROCESS | 1697 | |0;ai-astar;111;109;110;110;111;110;115;110;111;110 00:47:36 INFO - PROCESS | 1697 | |1;audio-beat-detection;157;120;145;155;118;142;140;119;156;118 00:47:36 INFO - PROCESS | 1697 | |2;audio-dft;256;261;218;185;184;183;184;184;181;184 00:47:36 INFO - PROCESS | 1697 | |3;audio-fft;77;81;85;79;56;61;57;80;104;56 00:47:36 INFO - PROCESS | 1697 | |4;audio-oscillator;93;102;129;109;119;122;112;77;77;109 00:47:36 INFO - PROCESS | 1697 | |5;imaging-gaussian-blur;86;90;85;91;84;90;84;92;84;92 00:47:36 INFO - PROCESS | 1697 | |6;imaging-darkroom;93;93;94;94;93;94;96;94;94;93 00:47:36 INFO - PROCESS | 1697 | |7;imaging-desaturate;85;88;84;87;87;96;121;87;85;88 00:47:36 INFO - PROCESS | 1697 | |8;json-parse-financial;58;53;53;53;53;54;55;64;52;53 00:47:36 INFO - PROCESS | 1697 | |9;json-stringify-tinderbox;64;62;73;78;70;67;66;67;68;67 00:47:36 INFO - PROCESS | 1697 | |10;stanford-crypto-aes;85;95;109;81;85;71;78;72;92;97 00:47:36 INFO - PROCESS | 1697 | |11;stanford-crypto-ccm;136;135;129;126;119;124;126;122;125;123 00:47:36 INFO - PROCESS | 1697 | |12;stanford-crypto-pbkdf2;140;125;137;135;139;127;139;138;135;140 00:47:36 INFO - PROCESS | 1697 | |13;stanford-crypto-sha256-iterative;66;67;66;65;67;66;67;77;91;94 00:47:36 INFO - PROCESS | 1697 | __end_tp_report 00:47:36 INFO - PROCESS | 1697 | __start_cc_report 00:47:36 INFO - PROCESS | 1697 | _x_x_mozilla_cycle_collect,1166 00:47:36 INFO - PROCESS | 1697 | __end_cc_report 00:47:36 INFO - PROCESS | 1697 | __startTimestamp1455094056815__endTimestamp 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | ------- Summary: start ------- 00:47:36 INFO - PROCESS | 1697 | Number of tests: 14 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#0] ai-astar Cycles:10 Average:110.70 Median:110.50 stddev:1.64 (1.5%) stddev-sans-first:1.73 00:47:36 INFO - PROCESS | 1697 | Values: 111.0 109.0 110.0 110.0 111.0 110.0 115.0 110.0 111.0 110.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:143.50 stddev:16.73 (11.7%) stddev-sans-first:16.10 00:47:36 INFO - PROCESS | 1697 | Values: 157.0 120.0 145.0 155.0 118.0 142.0 140.0 119.0 156.0 118.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#2] audio-dft Cycles:10 Average:202.00 Median:184.50 stddev:31.69 (17.2%) stddev-sans-first:26.93 00:47:36 INFO - PROCESS | 1697 | Values: 256.0 261.0 218.0 185.0 184.0 183.0 184.0 184.0 181.0 184.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#3] audio-fft Cycles:10 Average:73.60 Median:78.00 stddev:15.79 (20.2%) stddev-sans-first:16.70 00:47:36 INFO - PROCESS | 1697 | Values: 77.0 81.0 85.0 79.0 56.0 61.0 57.0 80.0 104.0 56.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:125.50 stddev:17.84 (14.2%) stddev-sans-first:18.39 00:47:36 INFO - PROCESS | 1697 | Values: 93.0 102.0 129.0 109.0 119.0 122.0 112.0 77.0 77.0 109.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:90.00 stddev:3.49 (3.9%) stddev-sans-first:3.64 00:47:36 INFO - PROCESS | 1697 | Values: 86.0 90.0 85.0 91.0 84.0 90.0 84.0 92.0 84.0 92.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 00:47:36 INFO - PROCESS | 1697 | Values: 93.0 93.0 94.0 94.0 93.0 94.0 96.0 94.0 94.0 93.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#7] imaging-desaturate Cycles:10 Average:90.80 Median:87.00 stddev:11.11 (12.8%) stddev-sans-first:11.59 00:47:36 INFO - PROCESS | 1697 | Values: 85.0 88.0 84.0 87.0 87.0 96.0 121.0 87.0 85.0 88.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:53.50 stddev:3.65 (6.8%) stddev-sans-first:3.68 00:47:36 INFO - PROCESS | 1697 | Values: 58.0 53.0 53.0 53.0 53.0 54.0 55.0 64.0 52.0 53.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:67.50 stddev:4.57 (6.8%) stddev-sans-first:4.58 00:47:36 INFO - PROCESS | 1697 | Values: 64.0 62.0 73.0 78.0 70.0 67.0 66.0 67.0 68.0 67.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:85.00 stddev:11.91 (14.0%) stddev-sans-first:12.62 00:47:36 INFO - PROCESS | 1697 | Values: 85.0 95.0 109.0 81.0 85.0 71.0 78.0 72.0 92.0 97.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:126.00 stddev:5.44 (4.3%) stddev-sans-first:4.56 00:47:36 INFO - PROCESS | 1697 | Values: 136.0 135.0 129.0 126.0 119.0 124.0 126.0 122.0 125.0 123.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.50 Median:138.50 stddev:5.34 (3.9%) stddev-sans-first:5.41 00:47:36 INFO - PROCESS | 1697 | Values: 140.0 125.0 137.0 135.0 139.0 127.0 139.0 138.0 135.0 140.0 00:47:36 INFO - PROCESS | 1697 | 00:47:36 INFO - PROCESS | 1697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:67.00 stddev:11.05 (16.5%) stddev-sans-first:11.46 00:47:36 INFO - PROCESS | 1697 | Values: 66.0 67.0 66.0 65.0 67.0 66.0 67.0 77.0 91.0 94.0 00:47:36 INFO - PROCESS | 1697 | -------- Summary: end -------- 00:47:36 INFO - PROCESS | 1697 | 00:47:37 INFO - TEST-INFO | 1697: exit 0 00:47:37 INFO - TEST-OK | kraken | took 57087ms 00:47:37 INFO - SUITE-END | took 1170s 00:47:37 INFO - Completed test suite (00:19:31) 00:47:37 INFO - Working with test: dromaeo_css 00:47:37 INFO - Generating results file: dromaeo_css 00:47:37 INFO - Working with test: kraken 00:47:37 INFO - Generating results file: kraken 00:47:37 INFO - javascript benchmark 00:47:37 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:47:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 00:47:38 INFO - process_Request line: dromaeo_css 7372.93 graph.html#tests=[[72,64,59]] 00:47:38 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:47:38 INFO - process_Request line: kraken 1444.70 graph.html#tests=[[232,64,59]] 00:47:38 INFO - RETURN: dromaeo_css: 7372.93 00:47:38 INFO - RETURN: kraken: 1444.70 00:47:38 INFO - javascript benchmark 00:47:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3476.7700327940765, 3477.930441391172, 3500.1774582973, 3541.62812904645, 3580.0154957386717, 5592.384837667863, 5647.3505546862025, 5685.3461851887, 5692.316921969365, 5704.800331988381, 5665.433456654332, 5669.8582535436635, 5739.713014349276, 5806.680632565207, 5812.622179558326, 5089.567386772129, 5124.000819840124, 5134.0758663440565, 5148.407933087706, 5219.504147106038, 5201.2458193561915, 5258.50044245796, 5265.8946821063555, 5273.209018647195, 5313.070212712779, 5109.412417571953, 5120.718360490153, 5186.170212765977, 5199.402068762065, 5236.92144617831, 5141.614378921596, 5185.325907632021, 5195.428502864682, 5212.713300768456, 5218.504242096995, 5101.260317254015, 5147.562457191143, 5171.715555644438, 5180.792768289264, 5191.766370513298, 5438.53772429344, 5574.024545704526, 5596.2165296858475, 5634.971825140848, 5637.379888212294, 6108.96945515274, 6144.201253837017, 6151.415615516519, 6153.138560601519, 6172.629642221436, 6141.232345956755, 6143.569950103494, 6168.629882207082, 6182.598131121463, 6237.656928868911, 4846.491118432585, 5661.830145095612, 5780.855478613068, 5810.215620891167, 5818.883622327529, 6247.843803904939, 6252.499800016079, 6259.906101408483, 6270.6864656766975, 6271.05934109878, 6073.18012068374, 6077.179580756541, 6112.877742445126, 6123.785667501616, 6135.509159267248, 6110.419510146529, 6129.695011270001, 6149.292831324455, 6210.130581718563, 6239.844003899848, 6148.354422785543, 6152.323244443108, 6164.599301045418, 6168.352323006109, 6175.289841668266, 6199.3490683477585, 6201.0, 6202.596831205957, 6207.441330280297, 6221.688915554204, 3833.8083095845095, 4796.952030479651, 4838.830640927551, 4841.05599408112, 4852.490488498657, 4368.36658684489, 4382.430284063115, 4410.647148228134, 4436.3567282743825, 4474.910501789946, 5684.426965843528, 5710.457506536873, 5730.34101078373, 5742.827715168552, 5754.079347304411, 6264.718087686065, 6266.561340706198, 6273.466755325849, 6280.0, 6283.748650054038, 5557.861053473695, 5695.974724549538, 5696.629719068247, 5766.654000759968, 5805.970970145207, 5320.228566857784, 5333.546648534918, 5344.278522399426, 5351.3578370595, 5354.303940487712, 6187.474064704551, 6287.685615719196, 6299.937000629935, 6304.747810087545, 6312.747490100436, 6118.954222337191, 6176.567640265138, 6262.906056409066, 6272.372762723691, 6278.246610406781, 6266.655333956676, 6273.780417685359, 6275.497960163268, 6291.339409361951, 6308.968455157695, 6015.947209238278, 6142.385761423822, 6165.599236049642, 6171.043488259327, 6183.319834818257, 6137.070562331885, 6228.0969259456215, 6234.0, 6242.282137554058, 6243.656598887105, 5977.432143946318, 5989.520838332835, 5998.580099393175, 6020.397960203944, 6058.0610005449225, 5779.913301300568, 5850.297964244148, 6008.339082700812, 6010.789622363196, 6019.307779605401, 5920.200772895776, 5920.585559010828, 5927.0, 5951.821445356646, 5955.940440595712, 6037.245344331958, 6060.969695151673, 6114.315000671675, 6116.670564642638, 6123.060032935882, 5793.623414478046, 5867.970660146672, 5890.7349169288345, 5963.493103086286, 5970.820875373745], "unit": "score", "name": "dojo.html", "value": 5667.186881705313}, {"lowerIsBetter": false, "replicates": [433.85682724700854, 438.3337327262561, 486.09586169724327, 495.9708604645362, 561.8930706508179, 29360.853195734016, 29739.702602973965, 29805.701942980562, 29877.80488780449, 29984.0, 34947.252637368154, 35625.109372265644, 38138.4279235811, 38792.22415551687, 38867.805660971724, 7827.139014708392, 9389.295802814782, 9395.953020234923, 9412.152906238438, 9415.95292023539, 9534.856977145348, 9681.0, 9688.951555242214, 9691.757706057335, 9697.612095516206, 9635.518224088803, 9696.70909872705, 9709.75725606862, 9711.75720606987, 9713.0, 8429.70496032639, 9705.223582113449, 9722.270829687732, 9802.75493112678, 9803.411795292306, 8683.739487815375, 9682.56428460721, 9831.606735730562, 9851.45816980073, 9858.16205622523, 39175.41236881449, 39519.4072088916, 39533.20933581341, 39604.40593391102, 39616.40575391342, 3440.397930362202, 3630.7640003399692, 3735.813209339522, 3748.175401411685, 3970.463987361698, 27798.583021254697, 28556.571651425245, 28705.28236794076, 28765.280867978257, 29510.0, 2705.742954419327, 2782.8608569571643, 2787.512185367553, 2963.940721185586, 2983.9104826855228, 466835.0, 467952.0, 468820.0, 470178.0, 471333.99999999657, 53053.46946530562, 54253.91492170213, 62059.0, 63244.68377658082, 63274.68362658157, 59382.0, 59617.0, 59883.0, 59889.0, 59953.0, 15799.763003554956, 15949.20253987296, 15989.680206395808, 16008.599785005235, 16026.839731602768, 10223.693289201336, 10543.156547476183, 12107.576234831915, 12685.365731713377, 12688.365581721062, 19018.0, 19054.714179287323, 19064.33274835374, 19066.713999290023, 19095.80904190968, 7247.528910620793, 8565.0, 8763.386562940661, 8772.912270877338, 8898.777530561787, 948.2271948362201, 980.2109302011949, 987.6543209876486, 1011.1657882247175, 1079.2499213047015, 28775.424491510472, 29337.332833395827, 29578.556321655193, 29739.0, 29832.552511712343, 1044.4151275285865, 1072.3887384190937, 1088.1175566270397, 1097.6268068856627, 1131.1562153689433, 11702.648920532398, 14070.226137562327, 14163.0, 14168.716625667636, 14300.785488217685, 520995.0, 528515.0, 528698.0, 530684.0, 531007.0, 53992.460075399526, 54370.91258174893, 54460.91078178414, 54589.0, 54647.726761365935, 1398.4196558428139, 1405.0726520496423, 1432.9928350358182, 1433.6702558411623, 1436.095259986202, 26914.0, 26990.73009269882, 27533.586996195474, 27650.5852412218, 27965.0, 37248.44127338146, 46155.307670384296, 46258.0, 46288.84277892945, 46419.0, 486115.0, 493031.0, 530405.0, 539434.0, 540808.0, 29109.69006394675, 29259.7074029257, 29339.119826405244, 29417.11748647544, 29530.261743455725, 40474.78575642735, 40696.59303406928, 40730.38904416377, 40759.59240407558, 41145.58854411537, 34404.0, 35280.588776448654, 35299.470507941885, 35412.64587354093, 35574.0, 33775.83112084424, 34463.96608101761, 34527.82736086303, 34624.307513850086, 34715.0, 33149.0, 33911.83044084764, 34189.97430077101, 34198.82900585481, 34238.14404639904, 29195.85402072976, 29455.96904108346, 30529.847350763994, 30547.0, 30592.235194120323, 23736.14301408197, 23936.0, 23955.640665389685, 24301.51396972086, 24466.085426332414], "unit": "score", "name": "ext.html", "value": 18953.604376344716}, {"lowerIsBetter": false, "replicates": [319.3134760265429, 370.92581483703265, 372.98508059677613, 375.9304528662196, 376.4936160863638, 14871.553853384388, 15130.243487825592, 18695.3456629018, 19713.21147154114, 20186.697199542017, 18496.98266595337, 18618.34835780748, 19290.03549822507, 19296.807031929675, 19326.903365483155, 5587.720613969295, 5751.281089863767, 5811.186433899257, 5812.331581868097, 5814.186013958049, 4133.607307305816, 4344.804483798237, 5688.63023903447, 5755.625884317506, 6041.667708276043, 6015.127806468059, 6194.163787888622, 6271.466925311354, 6271.749130034793, 6275.6548389838545, 6239.625622462667, 6239.875202495948, 6240.0, 6240.188775459184, 6249.343818899041, 5223.451537588575, 5311.389190243133, 5340.412554618989, 5372.382176049765, 5375.973120134413, 23350.64974025391, 24036.0, 24172.758272417228, 24222.152224672052, 24398.512029759306, 2246.539459410817, 2258.954820903573, 2392.0192720984487, 2524.9269060649335, 2558.769710726025, 13869.514566990107, 14403.78394324086, 14563.563093107117, 14814.925925370411, 14964.102153870803, 1585.715570387978, 1687.392538686072, 1747.2104197275946, 1805.142557285292, 1836.182898610119, 91311.0, 94387.0, 95404.56893146608, 97007.02992970121, 97797.51101244448, 10407.94796026015, 11178.27341222818, 11196.216264861545, 11228.101751859831, 11296.587926509186, 11090.944545277222, 13378.665533361744, 13467.730645387037, 13496.0, 13500.5274815381, 8364.832703345899, 8483.194096560817, 8501.404901656824, 8563.357748168912, 8573.528455934984, 6902.792916212522, 8570.614322355508, 8582.527960962207, 8643.481391116427, 8669.826603467895, 4036.7577945323374, 4365.257906155961, 4440.511543730187, 4476.798544065525, 4488.3940668010055, 1665.5086749408954, 1732.341710150135, 1748.4404990403202, 1750.5798608334162, 1850.9259629614935, 752.39808153477, 975.4977334904169, 985.8373368394134, 986.6004268271362, 991.0733464210986, 14534.927325363305, 16666.50000499987, 18801.90599046996, 19657.901710491355, 19905.701414478794, 883.7923088074298, 962.7544976031207, 966.1980556138528, 976.3507267667064, 1035.8601588785568, 8273.46222495536, 9413.529323533796, 9830.21358291335, 9861.0, 9928.751781205528, 528389.0, 532610.0, 539324.0, 597953.0, 660822.0, 71187.0, 82177.0, 115817.0, 117912.41043794726, 118869.40565297118, 1033.204432586904, 1154.7344110854551, 1171.3323405658693, 1190.922590031645, 1196.5632544121333, 17605.119744013005, 17910.0, 17924.283028678707, 17975.820241797413, 18226.45320640383, 49040.75479622579, 50495.49504504908, 51201.13589209019, 51631.74184129205, 51717.44847654577, 71937.0, 72241.0, 72465.6376718113, 72965.79790717635, 73185.53628927498, 7234.529755565872, 7389.815254618463, 7398.889016664647, 7460.179380268058, 7557.848843023219, 7892.921070789219, 9015.684451044444, 9460.337776355864, 10911.945440272748, 11755.529778808752, 9700.708978730649, 9978.0, 10203.489825508546, 10277.9486102569, 10496.370217786956, 7267.890981635174, 9608.183304419203, 9625.0, 10241.590336386462, 10391.636292729718, 9757.853632195665, 10181.33821301613, 10418.270721049454, 10501.369917804956, 10838.783224335311, 7482.139553951365, 7672.8849067265155, 7676.577788221702, 7677.539347639159, 7685.385169186564, 10121.0, 10486.26596138263, 10736.89263107359, 10764.3541387517, 10768.030877221088], "unit": "score", "name": "jquery.html", "value": 9084.381812296706}, {"lowerIsBetter": false, "replicates": [1357.8913686905046, 1385.4527461652654, 1568.4196847166547, 1765.170369926135, 1962.5584243545204, 7964.601769911503, 8571.185737354957, 8705.998810136836, 8712.782180445483, 8715.25920296774, 8355.83288334233, 8634.352423568225, 8636.91363086369, 8637.956810215941, 8677.783055423617, 2178.346496051186, 2236.563870045342, 2443.51129774045, 2469.666595009673, 2476.4923190745944, 2469.71598266199, 2507.8746062696882, 2517.6223566465087, 2517.773400393964, 2518.609615509599, 2469.1358024691303, 2498.8250822442437, 2503.399184195798, 2505.2734706934966, 2506.3358210074343, 2410.6384042393693, 2472.2336075816374, 2475.2450502596703, 2484.63972723954, 2484.776370126697, 2432.0636554926305, 2464.667269918556, 2477.306354220821, 2480.8139389545854, 2483.242611003643, 8693.521856297964, 8757.168069033432, 8780.64877404903, 8787.384883058188, 8806.955965220197, 4782.258749893772, 5239.502247286539, 5290.629655924087, 5486.643368181095, 5489.011977843987, 3546.9891081042038, 3589.73077019222, 3645.216278500135, 3668.284684486526, 3670.119171398872, 1039.8752149742004, 1040.531760707677, 1047.4553232319151, 1096.5230124895616, 1102.3055475050667, 11856.762864742743, 11875.52497900083, 11879.465424055852, 11881.702957426047, 11887.465064072137, 4874.561289483963, 4888.975555122272, 4945.826896058621, 4977.427595826454, 4980.402351717817, 10222.64220752285, 10240.64157754475, 10246.846297305547, 10251.026152515498, 10255.897441025643, 5480.780768769284, 5506.063969125178, 5511.4213007633625, 5515.751791169407, 5518.586106042063, 4950.455449900508, 5017.046761115376, 5019.14674505335, 5025.221090730943, 5032.194848824244, 3935.134270460494, 3969.563348031714, 3986.60133986599, 4012.257732319472, 4028.234635419261, 1302.6873550348039, 1303.0878385130447, 1303.2506308872437, 1304.4130141436392, 1330.8003799430162, 1299.0906365544156, 1299.7660421124099, 1315.9144655597356, 1353.282760137129, 1355.302019459979, 8157.510549366938, 8158.469699469515, 8171.0, 8188.099309075997, 8198.098209196984, 448.9416375871116, 473.61637073970195, 485.97813098410654, 489.21236808737905, 516.7855340033843, 6176.690418057629, 6204.410580994799, 6247.344028876993, 6248.250209974741, 6255.718492667841, 10386.221033422524, 10773.730656733644, 10785.946070269598, 10871.021608055313, 10874.18443616732, 10422.21833362501, 10609.939006099328, 10745.301555398873, 10759.515821788038, 10773.138148948065, 8101.0, 8191.303739182236, 8202.917970820215, 8303.709370172015, 8311.625976831057, 7677.577733224726, 7844.921550784419, 7852.803679908048, 7861.52830830152, 7880.960595196987, 9178.770530736785, 9452.196563292197, 9572.042795720372, 9709.805803884024, 9715.902840971783, 9244.168024877794, 9538.23694104456, 9591.040895910353, 10004.049615286536, 10026.0, 6568.6058836469965, 6779.525433219627, 7147.499675022698, 7372.0, 7416.369608583331, 8120.75637730869, 8158.796030099295, 8188.0, 8191.017077950684, 8226.30076443509, 7423.294786995443, 7683.807904802425, 7689.807754806175, 7794.947682063076, 7819.41354398411, 7446.70213191488, 7580.469367144247, 7598.316151546387, 7658.0, 7697.076350837935, 7671.8849217262905, 7700.037495313086, 7758.224177582197, 7761.456698031309, 7770.339521140766, 7028.964855175692, 7082.5396349237135, 7086.787396378117, 7097.325754053357, 7102.9289707104335, 7163.570185788869, 7206.387457066208, 7231.63841807897, 7240.0, 7240.239774823778], "unit": "score", "name": "mootools.html", "value": 4848.427582171612}, {"lowerIsBetter": false, "replicates": [320.87325506424963, 326.99019029429127, 331.3604742846306, 333.07405412951994, 335.7280602711802, 6472.935270647292, 6608.2730899601065, 6622.139121914151, 6631.137952066237, 6669.999500074979, 6565.6060636361735, 6577.473802095833, 6584.0, 6600.933990660092, 6601.240857301412, 3948.585398533163, 4789.688670236441, 4856.417229932413, 4862.610991120702, 4863.610911127119, 4878.02439512099, 4878.48775878533, 4880.3655524781725, 4882.926756098661, 4900.460949295592, 4603.723776573416, 4637.9072418551605, 4698.788554515055, 4773.403324584427, 4839.4918533554, 4705.223638099709, 4779.498152693969, 4784.067106914154, 4789.185838407444, 4813.205821039524, 4039.979800100981, 4083.775392353419, 4086.4074709167303, 4095.7337773044655, 4101.138760860223, 6257.155284036642, 6295.2760432550385, 6307.9684601577155, 6332.810015699491, 6337.651429171394, 4625.699329543569, 5488.290663020925, 5559.942031882449, 5626.549876009909, 5631.324241091054, 5695.943040569583, 6459.837229298724, 6997.335253150994, 6998.545094568837, 7007.82480437988, 4070.5115386153852, 4329.740215587075, 4532.229520981441, 4534.88662783433, 4555.453345598549, 6227.906581401283, 7251.0, 7436.851262974765, 7445.404367650575, 7460.104787425544, 4598.540145985375, 4610.53894610543, 4625.167469855391, 4633.907321853544, 4639.512851150648, 3996.540397854284, 4593.908121837611, 4690.15577196108, 4694.929576056362, 4712.9057418851435, 5397.8110766123, 5415.6479828811, 5567.888642227133, 5604.0, 5606.747696353674, 6046.969765151146, 6384.457321127663, 6467.579607325509, 7049.823754406181, 7096.148462184571, 1601.5355546891271, 1625.07370798646, 1627.9267432965546, 1630.3315640587539, 1631.5431679129863, 1028.4651980969854, 1039.3971496531992, 1050.894910508943, 1051.0645525482328, 1067.8398240264023, 5856.502197313191, 6287.622742635456, 6640.335966403321, 6667.766628168088, 6675.79972600813, 7298.927010729931, 7318.926810731825, 7324.96337518309, 7335.166208447888, 7342.559446433231, 6403.0, 6634.933650663528, 6637.502187335969, 6668.833279167962, 6669.566478178903, 3814.1418180909072, 3835.463035175078, 3841.154945911895, 3846.480725102131, 3849.0177558557366, 6082.452579267799, 6088.634681919099, 7515.173330933593, 7531.585762783099, 7560.810979725441, 7296.16094149169, 7375.4099672026105, 7382.409407247407, 7384.852302953911, 7573.697052117964, 6232.657203853832, 6295.716692748837, 7015.421530155674, 7799.181085986003, 7821.726239581587, 7416.110066791804, 7429.294217049372, 7434.553926764412, 7449.44129190302, 7461.589612571143, 6989.301069893173, 7056.682449289691, 7136.0, 7197.496175267681, 7344.853102938018, 7760.417968652261, 7799.259070388304, 7803.336716378944, 7811.570363629828, 7821.0, 4617.445906491243, 4665.486796452456, 4667.509911459248, 4680.695754775928, 4689.507601701908, 6469.061986011908, 6673.766418175341, 7365.1530074042175, 7391.556506609406, 7395.889061663972, 7105.50261481712, 7112.786616401516, 7118.145822501126, 7121.216666166614, 7125.394341481032, 6897.48268879826, 7111.111111111111, 7121.359077683033, 7127.501074924706, 7146.714131434893, 5636.0, 5665.461781130786, 6281.371862813865, 6368.395002474757, 6944.861102777815, 7086.326798954091, 7092.503524753218, 7119.466040046914, 7124.465665075244, 7126.109236345457, 5698.772049117989, 6773.05177275172, 6949.7567585134275, 6953.235144134243, 6954.930450695429], "unit": "score", "name": "prototype.html", "value": 5070.924679856984}, {"lowerIsBetter": false, "replicates": [639.5171645407719, 665.6738198282843, 673.6968364236094, 680.6290571638457, 748.147112291987, 12760.617181484558, 14863.10821350717, 15114.0, 15118.773218401719, 15119.244037798107, 14343.13941163531, 14419.639509012253, 14423.567292981228, 14429.278536073181, 14452.566423007327, 686.601770972837, 700.3381804195038, 839.8026463781007, 846.6571038729325, 860.2945584620613, 714.4106112457217, 849.3969281809923, 861.2291998661194, 863.0204717645486, 863.9006514250879, 912.6668765900465, 913.5477938420491, 914.6250037484633, 915.0712027292303, 917.3578495053456, 672.37133280383, 685.0717278088218, 715.706560310273, 729.9854002919965, 734.0787311923555, 660.6069388713707, 672.515788632184, 676.4892506157869, 676.8307923019245, 677.3226773226774, 14837.406503739838, 14860.182689952047, 14876.181810000446, 14894.553163405115, 14906.627334316621, 12162.756744865143, 12269.0, 12335.321557314344, 12636.0, 12741.299228542426, 9694.854577181348, 9820.803583928353, 9852.064053914866, 9890.80218395628, 10012.29913906027, 2931.4723349797027, 3491.162121090945, 3513.367593833109, 3536.7701099428455, 3662.505561749156, 76559.0, 78315.6084219581, 78319.60840195819, 78457.60771196107, 78506.0, 9249.956349305385, 9346.222158098673, 9454.05459454049, 9465.952670236606, 9471.952640236756, 20992.221400147813, 21174.87090017432, 21182.15271389158, 21200.681989770164, 21208.15167393287, 7158.964205178941, 7268.781936541912, 7434.3309102181065, 7443.8883416748795, 7496.287852654098, 3992.8802135935966, 4034.4755181826763, 4082.387641853686, 4107.199096176217, 4259.169461954889, 3370.831458427069, 3427.0232983599553, 3428.6571342865514, 3431.742619303562, 3435.158386195398, 620.6121174266084, 627.9215098112736, 632.8987362022054, 635.3392471829246, 640.810960766575, 513.5070332480785, 528.7831988884539, 573.5669569475019, 583.4311546242379, 604.5103466192311, 8534.0, 8540.103289154673, 8555.572221388906, 8806.075362087016, 8823.470591764386, 489.6890474548616, 511.98464046078675, 548.4916479680877, 603.6679826095717, 606.6511755740379, 3729.4965179700935, 3784.8864534064023, 4075.694322925792, 4086.244044851712, 4230.323148296319, 66535.66732166309, 67353.98969015469, 85981.0, 93726.53136734273, 95131.43817056499, 77164.0, 77582.0, 78032.21967780363, 78544.0, 79141.81287280696, 70360.64819675869, 72507.91238131432, 73046.63476682689, 73598.26401735914, 74015.25984740084, 8693.826123477622, 8704.0, 8791.208791208823, 8844.380893337404, 9143.759778854223, 46941.765291173324, 47357.0, 48280.7585962068, 48503.787405315146, 50394.244086339466, 63129.737405252556, 63719.044214335896, 64574.35425645871, 65348.01977970429, 65986.01020984785, 11259.211855170059, 11326.32042077478, 11599.188056835941, 11634.592789252336, 11735.706607334885, 10196.796064078826, 12009.879901200877, 12387.62837114888, 12418.813717794059, 12530.624081277576, 10683.5192416343, 10911.672649820519, 10936.015758581765, 11254.38100904458, 11704.94147529257, 11222.607208747655, 11288.548458061585, 11302.547898083985, 11417.885821141683, 12355.505779769068, 8330.637915543575, 10138.898611013796, 10451.529681164518, 11411.714707132389, 11502.53989840397, 8893.777655558662, 9282.489463079595, 9293.163615274387, 9477.668281610111, 9544.522773861418, 7476.962615186889, 9094.022864120761, 9179.954100229455, 9386.296027797805, 9503.429794212369], "unit": "score", "name": "yui.html", "value": 6695.1778892868515}], "name": "dromaeo_css", "value": 7372.9250784481}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 110.0, 111.0, 110.0, 115.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [157.0, 120.0, 145.0, 155.0, 118.0, 142.0, 140.0, 119.0, 156.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 137.0}, {"lowerIsBetter": true, "replicates": [256.0, 261.0, 218.0, 185.0, 184.0, 183.0, 184.0, 184.0, 181.0, 184.0], "unit": "score", "name": "audio-dft", "value": 202.0}, {"lowerIsBetter": true, "replicates": [77.0, 81.0, 85.0, 79.0, 56.0, 61.0, 57.0, 80.0, 104.0, 56.0], "unit": "score", "name": "audio-fft", "value": 73.6}, {"lowerIsBetter": true, "replicates": [93.0, 102.0, 129.0, 109.0, 119.0, 122.0, 112.0, 77.0, 77.0, 109.0], "unit": "score", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [86.0, 90.0, 85.0, 91.0, 84.0, 90.0, 84.0, 92.0, 84.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 94.0, 93.0, 94.0, 96.0, 94.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.8}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 84.0, 87.0, 87.0, 96.0, 121.0, 87.0, 85.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 90.8}, {"lowerIsBetter": true, "replicates": [58.0, 53.0, 53.0, 53.0, 53.0, 54.0, 55.0, 64.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 73.0, 78.0, 70.0, 67.0, 66.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [85.0, 95.0, 109.0, 81.0, 85.0, 71.0, 78.0, 72.0, 92.0, 97.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [136.0, 135.0, 129.0, 126.0, 119.0, 124.0, 126.0, 122.0, 125.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.5}, {"lowerIsBetter": true, "replicates": [140.0, 125.0, 137.0, 135.0, 139.0, 127.0, 139.0, 138.0, 135.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 65.0, 67.0, 66.0, 67.0, 77.0, 91.0, 94.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.6}], "name": "kraken", "value": 1444.6999999999998}]} 00:47:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1444.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7372.93"}}} 00:47:38 INFO - Return code: 0 00:47:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:47:38 INFO - # TBPL SUCCESS # 00:47:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:47:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:47:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:47:38 INFO - 2016-02-10 00:47:38.501 screenresolution[1701:12517] starting screenresolution argv=screenresolution get 00:47:38 INFO - 2016-02-10 00:47:38.504 screenresolution[1701:12517] Display 0: 1600x1200x32@60 00:47:38 INFO - 2016-02-10 00:47:38.510 screenresolution[1702:12520] starting screenresolution argv=screenresolution list 00:47:38 INFO - Available Modes on Display 0 00:47:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:47:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:47:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:47:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:47:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:47:38 INFO - Intel Iris: 00:47:38 INFO - Chipset Model: Intel Iris 00:47:38 INFO - Type: GPU 00:47:38 INFO - Bus: Built-In 00:47:38 INFO - VRAM (Dynamic, Max): 1536 MB 00:47:38 INFO - Vendor: Intel (0x8086) 00:47:38 INFO - Device ID: 0x0a2e 00:47:38 INFO - Revision ID: 0x0009 00:47:38 INFO - Displays: 00:47:38 INFO - Display: 00:47:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:47:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:47:38 INFO - Display Serial Number: 1600x1200 60 00:47:38 INFO - Main Display: Yes 00:47:38 INFO - Mirror: Off 00:47:38 INFO - Online: Yes 00:47:38 INFO - Rotation: Supported 00:47:38 INFO - Return code: 0 00:47:38 INFO - Running post-action listener: _resource_record_post_action 00:47:38 INFO - Running post-run listener: _resource_record_post_run 00:47:39 INFO - Total resource usage - Wall time: 1208s; CPU: 52.0%; Read bytes: 33840640; Write bytes: 708259328; Read time: 349; Write time: 1897 00:47:39 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 397566464; Write bytes: 391755776; Read time: 30107; Write time: 733 00:47:39 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 32054784; Write bytes: 300807680; Read time: 331; Write time: 1125 00:47:39 INFO - Running post-run listener: _upload_blobber_files 00:47:39 INFO - Blob upload gear active. 00:47:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:47:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:47:40 INFO - (blobuploader) - INFO - Open directory for files ... 00:47:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:47:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:47:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:47:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:47:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:47:41 INFO - (blobuploader) - INFO - Done attempting. 00:47:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:47:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:47:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:47:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:47:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:47:42 INFO - (blobuploader) - INFO - Done attempting. 00:47:42 INFO - (blobuploader) - INFO - Iteration through files over. 00:47:42 INFO - Return code: 0 00:47:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:47:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:47:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c7e623b70adad741eac4ad206fedad179f9dd14f6f49c65682d68ea4bff353a8215239501fd9d938d43dd1e443ffe90c4e4033213946c033b287773839391c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20b9f483483da9744cf76bf5d4a12fb02c25ba73f1f391b8e9913a8369e6316adb44a53e669409d4f69a77b5c3605a1a8ee2ff742ce418eca701eed740456194"} 00:47:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:47:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:47:42 INFO - Contents: 00:47:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c7e623b70adad741eac4ad206fedad179f9dd14f6f49c65682d68ea4bff353a8215239501fd9d938d43dd1e443ffe90c4e4033213946c033b287773839391c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20b9f483483da9744cf76bf5d4a12fb02c25ba73f1f391b8e9913a8369e6316adb44a53e669409d4f69a77b5c3605a1a8ee2ff742ce418eca701eed740456194"} 00:47:42 INFO - Running post-run listener: copy_logs_to_upload_dir 00:47:42 INFO - Copying logs to upload dir... 00:47:42 INFO - mkdir: /builds/slave/test/build/upload/logs 00:47:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.152781 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-02-10 00:47:42.556166) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 00:47:42.559218) ========= 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.UMolHtZHlK/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.m9mNMMSvwy/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c7e623b70adad741eac4ad206fedad179f9dd14f6f49c65682d68ea4bff353a8215239501fd9d938d43dd1e443ffe90c4e4033213946c033b287773839391c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20b9f483483da9744cf76bf5d4a12fb02c25ba73f1f391b8e9913a8369e6316adb44a53e669409d4f69a77b5c3605a1a8ee2ff742ce418eca701eed740456194"} build_url:https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/NCcFjjuWT2uU1SEh40gFqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c7e623b70adad741eac4ad206fedad179f9dd14f6f49c65682d68ea4bff353a8215239501fd9d938d43dd1e443ffe90c4e4033213946c033b287773839391c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20b9f483483da9744cf76bf5d4a12fb02c25ba73f1f391b8e9913a8369e6316adb44a53e669409d4f69a77b5c3605a1a8ee2ff742ce418eca701eed740456194"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 00:47:42.585173) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 00:47:42.585461) ========= 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.UMolHtZHlK/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.m9mNMMSvwy/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005077 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 00:47:42.633359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 00:47:42.633641) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 00:47:42.633986) ========= ========= Total master_lag: 0.50 =========