builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0129 starttime: 1458043648.86 results: success (0) buildid: 20160315032144 builduid: 1b39cdeffec74bc2b9d818c5f7ea5437 revision: c55260f518359813e95ac59b4af8b54f09946f49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:28.857342) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:28.857723) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:28.858022) ========= 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.c7ksMjojXl/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.r2MPfN9lcm/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005638 basedir: '/builds/slave/test' ========= master_lag: 0.33 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:29.192220) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:29.192527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:29.833148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:29.833422) ========= 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.c7ksMjojXl/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.r2MPfN9lcm/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005448 ========= master_lag: 0.26 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:30.100765) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:30.101049) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:30.101378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:30.101653) ========= 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.c7ksMjojXl/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.r2MPfN9lcm/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-15 05:07:30-- 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% 203M=0s 2016-03-15 05:07:30 (203 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128015 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:30.260554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:30.260885) ========= 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.c7ksMjojXl/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.r2MPfN9lcm/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.025517 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:30.458008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:30.458352) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c55260f518359813e95ac59b4af8b54f09946f49 --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 c55260f518359813e95ac59b4af8b54f09946f49 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.c7ksMjojXl/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.r2MPfN9lcm/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-15 05:07:30,553 truncating revision to first 12 chars 2016-03-15 05:07:30,554 Setting DEBUG logging. 2016-03-15 05:07:30,554 attempt 1/10 2016-03-15 05:07:30,554 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c55260f51835?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 05:07:31,215 unpacking tar archive at: fx-team-c55260f51835/testing/mozharness/ program finished with exit code 0 elapsedTime=0.909021 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:31.402185) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:31.402500) ========= echo c55260f518359813e95ac59b4af8b54f09946f49 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c55260f518359813e95ac59b4af8b54f09946f49'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.c7ksMjojXl/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.r2MPfN9lcm/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 c55260f518359813e95ac59b4af8b54f09946f49 program finished with exit code 0 elapsedTime=0.005600 script_repo_revision: 'c55260f518359813e95ac59b4af8b54f09946f49' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:31.461727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:31.465040) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 05:07:31.478906) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-15 05:07:31.479190) ========= /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.c7ksMjojXl/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.r2MPfN9lcm/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 05:07:31 INFO - MultiFileLogger online at 20160315 05:07:31 in /builds/slave/test 05:07:31 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 05:07:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:31 INFO - {'append_to_log': False, 05:07:31 INFO - 'base_work_dir': '/builds/slave/test', 05:07:31 INFO - 'blob_upload_branch': 'Fx-Team', 05:07:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:31 INFO - 'branch': 'Fx-Team', 05:07:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:31 INFO - 'config_files': ('talos/mac_config.py',), 05:07:31 INFO - 'default_actions': ('clobber', 05:07:31 INFO - 'read-buildbot-config', 05:07:31 INFO - 'download-and-extract', 05:07:31 INFO - 'populate-webroot', 05:07:31 INFO - 'create-virtualenv', 05:07:31 INFO - 'install', 05:07:31 INFO - 'run-tests'), 05:07:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:31 INFO - 'download_minidump_stackwalk': True, 05:07:31 INFO - 'download_symbols': 'ondemand', 05:07:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:31 INFO - 'installer_path': 'installer.exe', 05:07:31 INFO - 'log_level': 'info', 05:07:31 INFO - 'log_name': 'talos', 05:07:31 INFO - 'log_to_console': True, 05:07:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:07:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:07:31 INFO - 'opt_config_files': (), 05:07:31 INFO - 'pip_index': False, 05:07:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:31 INFO - 'cmd': ('bash', 05:07:31 INFO - '-c', 05:07:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:31 INFO - 'enabled': True, 05:07:31 INFO - 'halt_on_failure': False, 05:07:31 INFO - 'name': 'check_screen_resolution'},), 05:07:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:31 INFO - 'cmd': ('bash', 05:07:31 INFO - '-c', 05:07:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:31 INFO - 'enabled': True, 05:07:31 INFO - 'halt_on_failure': False, 05:07:31 INFO - 'name': 'check_screen_resolution'},), 05:07:31 INFO - 'run_cmd_checks_enabled': True, 05:07:31 INFO - 'sps_profile': False, 05:07:31 INFO - 'sps_profile_interval': 0, 05:07:31 INFO - 'suite': 'dromaeojs', 05:07:31 INFO - 'system_bits': '32', 05:07:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:31 INFO - 'title': 't-yosemite-r7-0129', 05:07:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:31 INFO - 'use_talos_json': True, 05:07:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:31 INFO - 'work_dir': 'build'} 05:07:31 INFO - ##### 05:07:31 INFO - ##### Running clobber step. 05:07:31 INFO - ##### 05:07:31 INFO - Running pre-action listener: _resource_record_pre_action 05:07:31 INFO - Running main action method: clobber 05:07:31 INFO - rmtree: /builds/slave/test/build 05:07:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:33 INFO - Running post-action listener: _resource_record_post_action 05:07:33 INFO - ##### 05:07:33 INFO - ##### Running read-buildbot-config step. 05:07:33 INFO - ##### 05:07:33 INFO - Running pre-action listener: _resource_record_pre_action 05:07:33 INFO - Running main action method: read_buildbot_config 05:07:33 INFO - Using buildbot properties: 05:07:33 INFO - { 05:07:33 INFO - "project": "", 05:07:33 INFO - "product": "firefox", 05:07:33 INFO - "script_repo_revision": "production", 05:07:33 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:07:33 INFO - "repository": "", 05:07:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:07:33 INFO - "buildid": "20160315032144", 05:07:33 INFO - "pgo_build": "False", 05:07:33 INFO - "basedir": "/builds/slave/test", 05:07:33 INFO - "buildnumber": 497, 05:07:33 INFO - "slavename": "t-yosemite-r7-0129", 05:07:33 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:07:33 INFO - "platform": "yosemite_r7", 05:07:33 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:07:33 INFO - "branch": "fx-team", 05:07:33 INFO - "repo_path": "integration/fx-team", 05:07:33 INFO - "revision": "c55260f518359813e95ac59b4af8b54f09946f49", 05:07:33 INFO - "stage_platform": "macosx64", 05:07:33 INFO - "builduid": "1b39cdeffec74bc2b9d818c5f7ea5437", 05:07:33 INFO - "slavebuilddir": "test" 05:07:33 INFO - } 05:07:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:07:33 INFO - Running post-action listener: _resource_record_post_action 05:07:33 INFO - ##### 05:07:33 INFO - ##### Running download-and-extract step. 05:07:33 INFO - ##### 05:07:33 INFO - Running pre-action listener: _resource_record_pre_action 05:07:33 INFO - Running main action method: download_and_extract 05:07:33 INFO - mkdir: /builds/slave/test/build/tests 05:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:33 INFO - https://queue.taskcluster.net/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:07:34 INFO - Downloaded 1199 bytes. 05:07:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:34 INFO - Using the following test package requirements: 05:07:34 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:07:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:34 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:07:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:34 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:07:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:34 INFO - u'jsshell-mac.zip'], 05:07:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:34 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:07:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:07:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:34 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:07:34 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:34 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:07:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:34 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:07:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:34 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:07:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:07:34 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')]} 05:07:34 INFO - https://queue.taskcluster.net/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:07:35 INFO - Downloaded 17853682 bytes. 05:07:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:07:38 INFO - Return code: 0 05:07:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:38 INFO - https://queue.taskcluster.net/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:07:42 INFO - Downloaded 17853682 bytes. 05:07:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:07:45 INFO - Return code: 0 05:07:45 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')]} 05:07:45 INFO - https://queue.taskcluster.net/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:07:47 INFO - Downloaded 10845263 bytes. 05:07:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:07:47 INFO - Return code: 0 05:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:47 INFO - https://queue.taskcluster.net/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:07:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:07:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:07:50 INFO - Downloaded 111186381 bytes. 05:07:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:50 INFO - mkdir: /builds/slave/test/properties 05:07:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:50 INFO - Contents: 05:07:50 INFO - build_url:https://queue.taskcluster.net/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:51 INFO - Running post-action listener: _resource_record_post_action 05:07:51 INFO - Running post-action listener: set_extra_try_arguments 05:07:51 INFO - ##### 05:07:51 INFO - ##### Running populate-webroot step. 05:07:51 INFO - ##### 05:07:51 INFO - Running pre-action listener: _resource_record_pre_action 05:07:51 INFO - Running main action method: populate_webroot 05:07:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:51 INFO - '--tppagecycles', 05:07:51 INFO - '7'], 05:07:51 INFO - 'tests': ['tsvgm']}}, 05:07:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:07:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:07:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:07:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:07:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:51 INFO - 'talos_options': ['--e10s'], 05:07:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:51 INFO - 'tests': ['damp', 'tps']}, 05:07:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:51 INFO - 'talos_options': ['--e10s'], 05:07:51 INFO - 'tests': ['damp', 'tps']}, 05:07:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:07:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:51 INFO - 'other': {'tests': ['a11yr', 05:07:51 INFO - 'ts_paint', 05:07:51 INFO - 'tpaint', 05:07:51 INFO - 'sessionrestore', 05:07:51 INFO - 'sessionrestore_no_auto_restore', 05:07:51 INFO - 'tabpaint']}, 05:07:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:07:51 INFO - 'tests': ['a11yr', 05:07:51 INFO - 'ts_paint', 05:07:51 INFO - 'tpaint', 05:07:51 INFO - 'sessionrestore', 05:07:51 INFO - 'sessionrestore_no_auto_restore', 05:07:51 INFO - 'tabpaint']}, 05:07:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:07:51 INFO - 'tests': ['a11yr', 05:07:51 INFO - 'ts_paint', 05:07:51 INFO - 'tpaint', 05:07:51 INFO - 'sessionrestore', 05:07:51 INFO - 'sessionrestore_no_auto_restore', 05:07:51 INFO - 'tabpaint']}, 05:07:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:07:51 INFO - 'tests': ['a11yr', 05:07:51 INFO - 'ts_paint', 05:07:51 INFO - 'tpaint', 05:07:51 INFO - 'sessionrestore', 05:07:51 INFO - 'sessionrestore_no_auto_restore', 05:07:51 INFO - 'tabpaint']}, 05:07:51 INFO - 'other_l64': {'tests': ['a11yr', 05:07:51 INFO - 'ts_paint', 05:07:51 INFO - 'tpaint', 05:07:51 INFO - 'sessionrestore', 05:07:51 INFO - 'sessionrestore_no_auto_restore', 05:07:51 INFO - 'tabpaint']}, 05:07:51 INFO - 'other_nol64': {'tests': ['a11yr', 05:07:51 INFO - 'ts_paint', 05:07:51 INFO - 'tpaint', 05:07:51 INFO - 'sessionrestore', 05:07:51 INFO - 'sessionrestore_no_auto_restore', 05:07:51 INFO - 'tabpaint']}, 05:07:51 INFO - 'svgr': {'tests': ['tsvgx', 05:07:51 INFO - 'tsvgr_opacity', 05:07:51 INFO - 'tart', 05:07:51 INFO - 'tscrollx', 05:07:51 INFO - 'cart']}, 05:07:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:07:51 INFO - 'tests': ['tsvgx', 05:07:51 INFO - 'tsvgr_opacity', 05:07:51 INFO - 'tart', 05:07:51 INFO - 'tscrollx', 05:07:51 INFO - 'cart']}, 05:07:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:51 INFO - 'tests': ['tp5o']}, 05:07:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:51 INFO - 'talos_options': ['--e10s'], 05:07:51 INFO - 'tests': ['tp5o']}, 05:07:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:51 INFO - 'talos_options': ['--xperf_path', 05:07:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:51 INFO - 'tests': ['tp5n']}, 05:07:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:51 INFO - 'talos_options': ['--e10s', 05:07:51 INFO - '--xperf_path', 05:07:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:51 INFO - 'tests': ['tp5n']}}, 05:07:51 INFO - 'talos.zip': {'path': '', 05:07:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:51 INFO - Running post-action listener: _resource_record_post_action 05:07:51 INFO - ##### 05:07:51 INFO - ##### Running create-virtualenv step. 05:07:51 INFO - ##### 05:07:51 INFO - Running pre-action listener: _resource_record_pre_action 05:07:51 INFO - Running main action method: create_virtualenv 05:07:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:51 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 05:07:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:51 INFO - Using real prefix '/tools/python27' 05:07:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:52 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:55 INFO - Installing pip.................done. 05:07:55 INFO - Return code: 0 05:07:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07:55 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')]} 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:55 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')]} 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:55 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 0x10497da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd12ac67250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104821d30>, '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 0x104645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.c7ksMjojXl/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.r2MPfN9lcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 05:07:55 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 05:07:55 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 05:07:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c7ksMjojXl/Render', 05:07:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:55 INFO - 'HOME': '/Users/cltbld', 05:07:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:55 INFO - 'LOGNAME': 'cltbld', 05:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:55 INFO - 'MOZ_NO_REMOTE': '1', 05:07:55 INFO - 'NO_EM_RESTART': '1', 05:07:55 INFO - 'PAGER': '/bin/cat', 05:07:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:55 INFO - 'PWD': '/builds/slave/test', 05:07:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:55 INFO - 'SHELL': '/bin/bash', 05:07:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2MPfN9lcm/Listeners', 05:07:55 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 05:07:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:55 INFO - 'USER': 'cltbld', 05:07:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:55 INFO - 'XPC_FLAGS': '0x0', 05:07:55 INFO - 'XPC_SERVICE_NAME': '0', 05:07:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:55 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 05:07:55 INFO - Cleaning up... 05:07:55 INFO - Return code: 0 05:07:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:07:55 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')]} 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:55 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')]} 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:55 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 0x10497da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd12ac67250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104821d30>, '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 0x104645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.c7ksMjojXl/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.r2MPfN9lcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 05:07:55 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 05:07:55 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 05:07:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c7ksMjojXl/Render', 05:07:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:55 INFO - 'HOME': '/Users/cltbld', 05:07:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:55 INFO - 'LOGNAME': 'cltbld', 05:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:55 INFO - 'MOZ_NO_REMOTE': '1', 05:07:55 INFO - 'NO_EM_RESTART': '1', 05:07:55 INFO - 'PAGER': '/bin/cat', 05:07:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:55 INFO - 'PWD': '/builds/slave/test', 05:07:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:55 INFO - 'SHELL': '/bin/bash', 05:07:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2MPfN9lcm/Listeners', 05:07:55 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 05:07:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:55 INFO - 'USER': 'cltbld', 05:07:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:55 INFO - 'XPC_FLAGS': '0x0', 05:07:55 INFO - 'XPC_SERVICE_NAME': '0', 05:07:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:55 INFO - Downloading/unpacking psutil>=0.7.1 05:07:55 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 05:07:55 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 05:07:55 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 05:07:55 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 05:07:55 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 05:07:55 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 05:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:59 INFO - Installing collected packages: psutil 05:07:59 INFO - Running setup.py install for psutil 05:07:59 INFO - building 'psutil._psutil_osx' extension 05:07:59 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 05:07:59 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 05:07:59 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 05:07:59 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 05:08:00 INFO - building 'psutil._psutil_posix' extension 05:08:00 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 05:08:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:08:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:08:00 INFO - ^ 05:08:00 INFO - 1 warning generated. 05:08:00 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 05:08:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:00 INFO - Successfully installed psutil 05:08:00 INFO - Cleaning up... 05:08:00 INFO - Return code: 0 05:08:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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', '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 0x10497da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd12ac67250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104821d30>, '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 0x104645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.c7ksMjojXl/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.r2MPfN9lcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 05:08: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:08: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 mozsystemmonitor==0.0.0 05:08:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c7ksMjojXl/Render', 05:08:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:00 INFO - 'HOME': '/Users/cltbld', 05:08:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:00 INFO - 'LOGNAME': 'cltbld', 05:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:00 INFO - 'MOZ_NO_REMOTE': '1', 05:08:00 INFO - 'NO_EM_RESTART': '1', 05:08:00 INFO - 'PAGER': '/bin/cat', 05:08:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:00 INFO - 'PWD': '/builds/slave/test', 05:08:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:00 INFO - 'SHELL': '/bin/bash', 05:08:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2MPfN9lcm/Listeners', 05:08:00 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 05:08:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:00 INFO - 'USER': 'cltbld', 05:08:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:00 INFO - 'XPC_FLAGS': '0x0', 05:08:00 INFO - 'XPC_SERVICE_NAME': '0', 05:08:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:08:03 INFO - Installing collected packages: mozsystemmonitor 05:08:03 INFO - Running setup.py install for mozsystemmonitor 05:08:03 INFO - Successfully installed mozsystemmonitor 05:08:03 INFO - Cleaning up... 05:08:03 INFO - Return code: 0 05:08:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:03 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')]} 05:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:03 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')]} 05:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:03 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 0x10497da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd12ac67250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104821d30>, '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 0x104645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.c7ksMjojXl/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.r2MPfN9lcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 05:08:03 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 05:08:03 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 05:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c7ksMjojXl/Render', 05:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:03 INFO - 'HOME': '/Users/cltbld', 05:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:03 INFO - 'LOGNAME': 'cltbld', 05:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:03 INFO - 'MOZ_NO_REMOTE': '1', 05:08:03 INFO - 'NO_EM_RESTART': '1', 05:08:03 INFO - 'PAGER': '/bin/cat', 05:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:03 INFO - 'PWD': '/builds/slave/test', 05:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:03 INFO - 'SHELL': '/bin/bash', 05:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2MPfN9lcm/Listeners', 05:08:03 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 05:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:03 INFO - 'USER': 'cltbld', 05:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:03 INFO - 'XPC_FLAGS': '0x0', 05:08:03 INFO - 'XPC_SERVICE_NAME': '0', 05:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:03 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 05:08:03 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 05:08:03 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 05:08:03 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 05:08:03 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 05:08:03 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 05:08:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:06 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 05:08:06 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 05:08:06 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 05:08:06 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 05:08:06 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 05:08:06 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 05:08:06 INFO - Downloading docopt-0.6.1.tar.gz 05:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:07 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:07 INFO - Running setup.py install for blobuploader 05:08:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:07 INFO - Running setup.py install for requests 05:08:07 INFO - Running setup.py install for docopt 05:08:07 INFO - Successfully installed blobuploader requests docopt 05:08:07 INFO - Cleaning up... 05:08:07 INFO - Return code: 0 05:08:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:07 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 0x10497da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd12ac67250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104821d30>, '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 0x104645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.c7ksMjojXl/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.r2MPfN9lcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 05:08:07 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 05:08:07 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 05:08:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c7ksMjojXl/Render', 05:08:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:08 INFO - 'HOME': '/Users/cltbld', 05:08:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:08 INFO - 'LOGNAME': 'cltbld', 05:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:08 INFO - 'MOZ_NO_REMOTE': '1', 05:08:08 INFO - 'NO_EM_RESTART': '1', 05:08:08 INFO - 'PAGER': '/bin/cat', 05:08:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:08 INFO - 'PWD': '/builds/slave/test', 05:08:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:08 INFO - 'SHELL': '/bin/bash', 05:08:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2MPfN9lcm/Listeners', 05:08:08 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 05:08:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:08 INFO - 'USER': 'cltbld', 05:08:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:08 INFO - 'XPC_FLAGS': '0x0', 05:08:08 INFO - 'XPC_SERVICE_NAME': '0', 05:08:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:08 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-1gvePn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:08 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-q4183P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:08 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-WvkdqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:08 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-6pKtmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:08 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-UyrCZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:08 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-CBgKIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:08 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-IfCud8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:08 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-wa_3G0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:09 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-KRS5Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:09 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-KnMrDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:09 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-h6Jy4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:09 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-aU3uo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:09 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-MOqVep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:09 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-wdlmq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:09 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-5lDlYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:09 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-FbuU_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:09 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-53Zuko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:09 INFO - Running setup.py install for manifestparser 05:08:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:10 INFO - Running setup.py install for mozcrash 05:08:10 INFO - Running setup.py install for mozdebug 05:08:10 INFO - Running setup.py install for mozdevice 05:08:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:10 INFO - Running setup.py install for mozfile 05:08:10 INFO - Running setup.py install for mozhttpd 05:08:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:10 INFO - Running setup.py install for mozinfo 05:08:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:11 INFO - Running setup.py install for mozInstall 05:08:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:11 INFO - Running setup.py install for mozleak 05:08:11 INFO - Running setup.py install for mozlog 05:08:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:11 INFO - Running setup.py install for moznetwork 05:08:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:11 INFO - Running setup.py install for mozprocess 05:08:11 INFO - Running setup.py install for mozprofile 05:08:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:11 INFO - Running setup.py install for mozrunner 05:08:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:12 INFO - Running setup.py install for mozscreenshot 05:08:12 INFO - Running setup.py install for moztest 05:08:12 INFO - Running setup.py install for mozversion 05:08:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:12 INFO - Cleaning up... 05:08:12 INFO - Return code: 0 05:08:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:12 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 0x10497da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd12ac67250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104821d30>, '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 0x104645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.c7ksMjojXl/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.r2MPfN9lcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 05:08:12 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 05:08:12 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 05:08:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c7ksMjojXl/Render', 05:08:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:12 INFO - 'HOME': '/Users/cltbld', 05:08:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:12 INFO - 'LOGNAME': 'cltbld', 05:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:12 INFO - 'MOZ_NO_REMOTE': '1', 05:08:12 INFO - 'NO_EM_RESTART': '1', 05:08:12 INFO - 'PAGER': '/bin/cat', 05:08:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:12 INFO - 'PWD': '/builds/slave/test', 05:08:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:12 INFO - 'SHELL': '/bin/bash', 05:08:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2MPfN9lcm/Listeners', 05:08:12 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 05:08:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:12 INFO - 'USER': 'cltbld', 05:08:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:12 INFO - 'XPC_FLAGS': '0x0', 05:08:12 INFO - 'XPC_SERVICE_NAME': '0', 05:08:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:12 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-NMx7YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:12 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)) 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:12 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Uv8YJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:13 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-cHRwQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:13 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)) 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:13 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-FsJ3K6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:13 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)) 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:13 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Ix_chF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:13 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)) 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:13 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-PCmySK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:13 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)) 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:13 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-xGX03c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:13 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)) 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:13 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-uo43wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:13 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)) 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:13 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-og_EYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:13 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)) 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:13 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-dw8QkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:13 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)) 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:13 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-bqLmya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:13 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)) 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:13 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-FVHahF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:14 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)) 05:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:14 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-O1tW_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:14 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)) 05:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:14 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Wg_i5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:14 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)) 05:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:14 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-izELpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:14 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)) 05:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:14 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-XLGsKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:14 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)) 05:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:14 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-EBhSIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:14 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)) 05:08:14 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:14 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:14 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)) 05:08:14 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)) 05:08:14 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)) 05:08:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:14 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 05:08:14 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 05:08:14 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 05:08:14 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 05:08:14 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 05:08:14 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 05:08:16 INFO - Downloading blessings-1.6.tar.gz 05:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:17 INFO - Installing collected packages: blessings 05:08:17 INFO - Running setup.py install for blessings 05:08:17 INFO - Successfully installed blessings 05:08:17 INFO - Cleaning up... 05:08:17 INFO - Return code: 0 05:08:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:17 INFO - Reading from file tmpfile_stdout 05:08:17 INFO - Current package versions: 05:08:17 INFO - blessings == 1.6 05:08:17 INFO - blobuploader == 1.2.4 05:08:17 INFO - docopt == 0.6.1 05:08:17 INFO - manifestparser == 1.1 05:08:17 INFO - mozInstall == 1.12 05:08:17 INFO - mozcrash == 0.17 05:08:17 INFO - mozdebug == 0.1 05:08:17 INFO - mozdevice == 0.48 05:08:17 INFO - mozfile == 1.2 05:08:17 INFO - mozhttpd == 0.7 05:08:17 INFO - mozinfo == 0.9 05:08:17 INFO - mozleak == 0.1 05:08:17 INFO - mozlog == 3.1 05:08:17 INFO - moznetwork == 0.27 05:08:17 INFO - mozprocess == 0.22 05:08:17 INFO - mozprofile == 0.28 05:08:17 INFO - mozrunner == 6.11 05:08:17 INFO - mozscreenshot == 0.1 05:08:17 INFO - mozsystemmonitor == 0.0 05:08:17 INFO - moztest == 0.7 05:08:17 INFO - mozversion == 1.4 05:08:17 INFO - psutil == 3.1.1 05:08:17 INFO - requests == 1.2.3 05:08:17 INFO - wsgiref == 0.1.2 05:08:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:17 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')]} 05:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:17 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')]} 05:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:17 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 0x10497da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd12ac67250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104821d30>, '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 0x104645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.c7ksMjojXl/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.r2MPfN9lcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 05:08:17 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 05:08:17 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 05:08:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c7ksMjojXl/Render', 05:08:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:17 INFO - 'HOME': '/Users/cltbld', 05:08:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:17 INFO - 'LOGNAME': 'cltbld', 05:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:17 INFO - 'MOZ_NO_REMOTE': '1', 05:08:17 INFO - 'NO_EM_RESTART': '1', 05:08:17 INFO - 'PAGER': '/bin/cat', 05:08:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:17 INFO - 'PWD': '/builds/slave/test', 05:08:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:17 INFO - 'SHELL': '/bin/bash', 05:08:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2MPfN9lcm/Listeners', 05:08:17 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 05:08:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:17 INFO - 'USER': 'cltbld', 05:08:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:17 INFO - 'XPC_FLAGS': '0x0', 05:08:17 INFO - 'XPC_SERVICE_NAME': '0', 05:08:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:17 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)) 05:08:17 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)) 05:08:17 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)) 05:08:17 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)) 05:08:17 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)) 05:08:17 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)) 05:08:17 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)) 05:08:17 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)) 05:08:17 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)) 05:08:17 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)) 05:08:17 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)) 05:08:17 INFO - Cleaning up... 05:08:17 INFO - Return code: 0 05:08:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:17 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')]} 05:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:17 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')]} 05:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:17 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 0x10497da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd12ac67250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104821d30>, '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 0x104645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.c7ksMjojXl/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.r2MPfN9lcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 05:08:17 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 05:08:17 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 05:08:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c7ksMjojXl/Render', 05:08:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:17 INFO - 'HOME': '/Users/cltbld', 05:08:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:17 INFO - 'LOGNAME': 'cltbld', 05:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:17 INFO - 'MOZ_NO_REMOTE': '1', 05:08:17 INFO - 'NO_EM_RESTART': '1', 05:08:17 INFO - 'PAGER': '/bin/cat', 05:08:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:17 INFO - 'PWD': '/builds/slave/test', 05:08:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:17 INFO - 'SHELL': '/bin/bash', 05:08:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2MPfN9lcm/Listeners', 05:08:17 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 05:08:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:17 INFO - 'USER': 'cltbld', 05:08:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:17 INFO - 'XPC_FLAGS': '0x0', 05:08:17 INFO - 'XPC_SERVICE_NAME': '0', 05:08:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:18 INFO - Downloading/unpacking jsonschema 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:20 INFO - Downloading/unpacking functools32 (from jsonschema) 05:08:20 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 05:08:20 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 05:08:20 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 05:08:20 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 05:08:20 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 05:08:20 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 05:08:20 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:20 INFO - warning: no files found matching '*.txt' 05:08:20 INFO - no previously-included directories found matching 'build' 05:08:20 INFO - no previously-included directories found matching 'dist' 05:08:20 INFO - no previously-included directories found matching '.git*' 05:08:20 INFO - Installing collected packages: jsonschema, functools32 05:08:20 INFO - Running setup.py install for functools32 05:08:21 INFO - warning: no files found matching '*.txt' 05:08:21 INFO - no previously-included directories found matching 'build' 05:08:21 INFO - no previously-included directories found matching 'dist' 05:08:21 INFO - no previously-included directories found matching '.git*' 05:08:21 INFO - Successfully installed jsonschema functools32 05:08:21 INFO - Cleaning up... 05:08:21 INFO - Return code: 0 05:08:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10497da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd12ac67250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104821d30>, '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 0x104645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, '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.c7ksMjojXl/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.r2MPfN9lcm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 05:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:08:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c7ksMjojXl/Render', 05:08:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:21 INFO - 'HOME': '/Users/cltbld', 05:08:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:21 INFO - 'LOGNAME': 'cltbld', 05:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:21 INFO - 'MOZ_NO_REMOTE': '1', 05:08:21 INFO - 'NO_EM_RESTART': '1', 05:08:21 INFO - 'PAGER': '/bin/cat', 05:08:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:21 INFO - 'PWD': '/builds/slave/test', 05:08:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:21 INFO - 'SHELL': '/bin/bash', 05:08:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2MPfN9lcm/Listeners', 05:08:21 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 05:08:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:21 INFO - 'USER': 'cltbld', 05:08:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:21 INFO - 'XPC_FLAGS': '0x0', 05:08:21 INFO - 'XPC_SERVICE_NAME': '0', 05:08:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:21 INFO - Downloading/unpacking flake8 05:08:21 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 05:08:21 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 05:08:21 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 05:08:21 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 05:08:21 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 05:08:21 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 05:08:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:08:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:08:23 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 05:08:23 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 05:08:23 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 05:08:23 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 05:08:23 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 05:08:23 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 05:08:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:08:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:08:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:24 INFO - no previously-included directories found matching 'docs/_build' 05:08:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:08:25 INFO - Running setup.py install for pep8 05:08:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:25 INFO - no previously-included directories found matching 'docs/_build' 05:08:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:08:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:08:25 INFO - Cleaning up... 05:08:25 INFO - Return code: 0 05:08:25 INFO - Running post-action listener: _resource_record_post_action 05:08:25 INFO - Running post-action listener: _start_resource_monitoring 05:08:25 INFO - Starting resource monitoring. 05:08:25 INFO - ##### 05:08:25 INFO - ##### Running install step. 05:08:25 INFO - ##### 05:08:25 INFO - Running pre-action listener: _resource_record_pre_action 05:08:25 INFO - Running main action method: install 05:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:25 INFO - Reading from file tmpfile_stdout 05:08:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:25 INFO - Reading from file tmpfile_stdout 05:08:25 INFO - Output received: 05:08:25 INFO - Usage: mozinstall [options] installer 05:08:25 INFO - Options: 05:08:25 INFO - -h, --help show this help message and exit 05:08:25 INFO - -d DEST, --destination=DEST 05:08:25 INFO - Directory to install application into. [default: 05:08:25 INFO - "/builds/slave/test"] 05:08:25 INFO - --app=APP Application being installed. [default: firefox] 05:08:25 INFO - mkdir: /builds/slave/test/build/application 05:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:09:00 INFO - Reading from file tmpfile_stdout 05:09:00 INFO - Output received: 05:09:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:09:00 INFO - Running post-action listener: _resource_record_post_action 05:09:00 INFO - ##### 05:09:00 INFO - ##### Running run-tests step. 05:09:00 INFO - ##### 05:09:00 INFO - Running pre-action listener: _resource_record_pre_action 05:09:00 INFO - Running main action method: run_tests 05:09:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:00 INFO - 2016-03-15 05:09:00.387 screenresolution[1641:7680] starting screenresolution argv=screenresolution get 05:09:00 INFO - 2016-03-15 05:09:00.389 screenresolution[1641:7680] Display 0: 1600x1200x32@60 05:09:00 INFO - 2016-03-15 05:09:00.395 screenresolution[1642:7682] starting screenresolution argv=screenresolution list 05:09:00 INFO - Available Modes on Display 0 05:09:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:00 INFO - Intel Iris: 05:09:00 INFO - Chipset Model: Intel Iris 05:09:00 INFO - Type: GPU 05:09:00 INFO - Bus: Built-In 05:09:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:09:00 INFO - Vendor: Intel (0x8086) 05:09:00 INFO - Device ID: 0x0a2e 05:09:00 INFO - Revision ID: 0x0009 05:09:00 INFO - Displays: 05:09:00 INFO - Display: 05:09:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:00 INFO - Display Serial Number: 1600x1200 60 05:09:00 INFO - Main Display: Yes 05:09:00 INFO - Mirror: Off 05:09:00 INFO - Online: Yes 05:09:00 INFO - Rotation: Supported 05:09:00 INFO - Return code: 0 05:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:00 INFO - Python 2.7.3 05:09:00 INFO - Return code: 0 05:09:00 INFO - grabbing minidump binary from tooltool 05:09: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')]} 05:09:00 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 0x104821d30>, '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 0x104645db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104818b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:00 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 05:09:00 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 05:09:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:00 INFO - Return code: 0 05:09:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:09:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:09:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:09:01 INFO - Return code: 0 05:09:01 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/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--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 05:09:01 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/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0129 --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 05:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c7ksMjojXl/Render', 05:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:01 INFO - 'HOME': '/Users/cltbld', 05:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:01 INFO - 'LOGNAME': 'cltbld', 05:09:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:01 INFO - 'MOZ_NO_REMOTE': '1', 05:09:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:01 INFO - 'NO_EM_RESTART': '1', 05:09:01 INFO - 'PAGER': '/bin/cat', 05:09:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:01 INFO - 'PWD': '/builds/slave/test', 05:09:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:01 INFO - 'SHELL': '/bin/bash', 05:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2MPfN9lcm/Listeners', 05:09:01 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 05:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:01 INFO - 'USER': 'cltbld', 05:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:01 INFO - 'XPC_FLAGS': '0x0', 05:09:01 INFO - 'XPC_SERVICE_NAME': '0', 05:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:01 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/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--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 05:09:02 INFO - mozversion application_buildid: 20160315032144 05:09:02 INFO - mozversion application_changeset: c55260f518359813e95ac59b4af8b54f09946f49 05:09:02 INFO - mozversion application_display_name: Nightly 05:09:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:02 INFO - mozversion application_name: Firefox 05:09:02 INFO - mozversion application_remotingname: firefox 05:09:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:09:02 INFO - mozversion application_vendor: Mozilla 05:09:02 INFO - mozversion application_version: 48.0a1 05:09:02 INFO - mozversion platform_buildid: 20160315032144 05:09:02 INFO - mozversion platform_changeset: c55260f518359813e95ac59b4af8b54f09946f49 05:09:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:09:02 INFO - mozversion platform_version: 48.0a1 05:09:02 INFO - using testdate: 1458043742 05:09:02 INFO - actual date: 1458043742 05:09:02 INFO - starting webserver on 'localhost:49271' 05:09:02 INFO - SUITE-START | Running 2 tests 05:09:02 INFO - TEST-START | dromaeo_css 05:09:02 INFO - operating with platform_type : mac_ 05:09:02 INFO - Initialising browser for dromaeo_css test... 05:09:02 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpY3Oi61/profile http://localhost:49271/getInfo.html) 05:09:04 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 05:09:04 INFO - PROCESS | 1660 | colorDepth:24 05:09:04 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 05:09:04 INFO - PROCESS | 1660 | __metrics 05:09:04 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:09:04 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:09:05 INFO - TEST-INFO | 1660: exit 0 05:09:05 INFO - Browser initialized. 05:09:05 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:05 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpY3Oi61/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:17 INFO - PROCESS | 1663 | RSS: Main: 243314688 05:09:17 INFO - PROCESS | 1663 | 05:10:08 INFO - PROCESS | 1663 | 1458043808278 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] 05:12:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 05:12:20 INFO - PROCESS | 1663 | RSS: Main: 350953472 05:12:20 INFO - PROCESS | 1663 | 05:15:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 05:15:23 INFO - PROCESS | 1663 | RSS: Main: 377913344 05:15:23 INFO - PROCESS | 1663 | 05:18:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 05:18:25 INFO - PROCESS | 1663 | RSS: Main: 369508352 05:18:25 INFO - PROCESS | 1663 | 05:21:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 05:21:28 INFO - PROCESS | 1663 | RSS: Main: 331378688 05:21:28 INFO - PROCESS | 1663 | 05:24:31 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 05:24:32 INFO - PROCESS | 1663 | RSS: Main: 333656064 05:24:32 INFO - PROCESS | 1663 | 05:27:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 05:27:35 INFO - PROCESS | 1663 | RSS: Main: 441049088 05:27:35 INFO - PROCESS | 1663 | 05:27:35 INFO - PROCESS | 1663 | __start_tp_report 05:27:35 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 05:27:35 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 05:27:35 INFO - PROCESS | 1663 | |i|pagename|runs| 05:27:35 INFO - PROCESS | 1663 | |0;dojo.html;3401.4557670772674;3481.042713253855;3488.1977145256574;3513.4554144107674;3544.379733546629;5500.257465242191;5567.916481252784;5575.2473416088815;5582.944170558293;5588.357338906027;5571.916421253684;5609.270794796681;5627.184058311543;5733.713314334277;5735.942640573593;5029.47190544993;5063.974680126595;5072;5097.770600322994;5182.067227898996;5182.844514664566;5186.636935414523;5218.32161818963;5241.50205730455;5265.473452654742;5029.949700502984;5044.54599086084;5105.463926287724;5126.128558145124;5158.561522270612;5141.0232055909255;5145.125328694131;5154.716490593016;5156.278121063054;5186.611004174664;5070.416902056237;5085.720285384303;5108.335916330853;5120.743962801882;5137.717425541631;5368.516833485005;5470.480304371078;5475.4524547544925;5481.451854814526;5561.972190139064;4982.277569752366;6075.878482430371;6117.296510901258;6125.693715314261;6132.540059495555;6095.664738439384;6149.446549810538;6162.537809664248;6168.999999999955;6174.8147555573405;5594.496495315441;5685.317761868602;5687.9431205687415;5691.430856914276;5696.51579615729;6054.727537260834;6108.35862234459;6161.84595385119;6162.907556386658;6164.568480206342;5971.164037034819;6049.727762250709;6067.7269522871575;6078.969605151946;6098.634081955008;6052.757889684452;6169.105479705418;6169.167162433104;6180.196574445384;6207.6275423474735;5610.831675049755;6017.669028203403;6089.48239399656;6127.080937859357;6129.419919118773;4955.4301255356095;6103.725332360054;6123.4795042421;6131.713108457284;6145.784897528565;4800.1119792838435;4801.063792560487;4807.567318941242;4816.20532612122;4849.612031037508;4197.8320867165585;4274.551172126944;4341.088371442032;4355.259605867011;4374.12517496502;5600.327960644749;5644.463775941279;5655.0103731847585;5673.0923052312255;5673.687947162945;4946.703197808143;6171.56799024073;6173.012318029184;6174.876502469925;6186.226721659793;5562.582806289544;5612.550995920316;5666.036773748473;5725.08398656213;5750.568707346965;5253.369595648546;5260;5265.842024739188;5266;5269.894602108013;6079.0273556230795;6214.161088253028;6219.502439804804;6233.34549872266;6238.532110091671;5132.563732082815;6069.666168360606;6133.579501509301;6138.171346868295;6188.938110618837;6187;6208.1308616792785;6246.125542424155;6257.780977665942;6260.40526150015;6012.6993650316435;6079;6099.603525770811;6106.175666284995;6110.419510146529;6055.182550355646;6066.241719785027;6125.111858780541;6161.722722477589;6184.536159787944;4848.224284114524;5353.705546194997;6009.248843894513;6014.458698717136;6030.577859549965;5944.791932282349;5988.640681559121;5991.670458124845;5993.220881285405;5995.490383317467;4807.61539076866;5579.832605021856;5698.6580805151825;5799.014167591436;5920.615160014758;5992.43071908168;5993.160957465871;5995.340512543704;6001.129836173643;6012.909806352821;5793.36273009977;5807.186993820784;5811.128330750421;5823.621464604787;5871.6183448075735 05:27:35 INFO - PROCESS | 1663 | |1;ext.html;480.5410832654815;578.6556998585843;580.9448102430271;631.7125707802952;643.2474005413666;38590.421143682834;39431.80284098582;39472.40791388132;39482.2103557929;39647.801760991155;41652;42519.51181708641;42599.14801703972;42626.360604590955;42674.78662606682;9323.860142097858;9579.712608621718;9581.90418095817;9584.137427631547;9585.856212156823;9444.81110377792;9575.808483830318;9592.08875156859;9722.611095556169;9757.512124393787;9628.13346798788;9743.317967742261;9749.512524373788;9752.268579856503;9758.316917815755;9663.855042174338;9738.707838764849;9740.074692904163;9742.07450292221;9809.754756131082;9520.476373799438;9628.759281017961;9654;9662.855057174149;9664.95167524165;41427;41894.371584426255;41913.16173676509;41917.74246772602;41946.37080443796;3279.212988882651;3331.233816222258;3439.5872495300473;3722.6091260417807;3778.4710140580064;28732.569011464635;28740.850365985334;30336.84831575828;30423.543646845315;30462;2335.6963594732747;2714.429969706364;2714.904978325749;2744.547149720294;2809.1993781772303;495117;497951;499284;499562.50218749035;500807;45204.095918082116;45696;45771.08457830825;45795;64607.353926460135;45018;45041.54958450439;45139;45155.54844451579;45202.77398612986;15732.60668483297;15926.920365398099;15933.521994340188;15966.920165399099;15989.920050399674;12776.6805829855;12848.229106253655;12850.485980560672;12859.614211573667;13003.349832508336;14756.63108422298;14768.113913165245;14770.778438323434;14783.408663653334;14945.402183912522;6466.191726034246;6658.935729923739;6710.1947766267385;6716.630585317756;6746.156730408699;1008.0927165551062;1013.2350075692952;1035.1822060572215;1040.635777477892;1086.1419478611965;29011.709882901323;29115.27211819679;29188.708112918597;29687;29863.95476158324;1078.5362294213564;1145.7536629624672;1156.2022204678913;1208.456194712383;1236.814477828315;14900.403983840743;14945.953783235069;15166.090034597959;15285.465008724641;15332.693346133015;522392;528224;529844;530384;530581;59812.700936495035;59953.700231498566;60001.699991499765;60152.097718534256;60205.39794601998;1335;1460.8173978252719;1465.7581499052537;1468.4419920430169;1492.7835463857898;28386.574201386582;29126.56310155307;29440.11679649614;29510.409791803613;30302.242443938198;47832;47922.76038619784;48195;48196.7590162047;48361;326691;328654;328669;328958;329031;28423.857880710464;32915.50626740649;33279;33839.66160338464;33940.83029584836;43038;44135;44232.778836105615;44433;45028.32457513206;35055.82472087623;36320.4551931716;36331.45502817513;37174.44238336481;37384.06539836526;35991.28017439584;36089.458658120675;36701.08247293839;36824.81587592152;36905.81547092248;35722.64277357193;36153.276934460635;36159.63840361563;36233.81883090568;36907.89276321715;31018.844905775328;31653;32717.345653087283;35387;35643.46534802032;20580.25067869188;23183;24664.506709866062;24714.876425617756;25293.747062529874 05:27:35 INFO - PROCESS | 1663 | |2;jquery.html;364.5206553382302;366.0555766123402;366.99633003669953;375.6656575647674;377.7185996432658;19515.70726439103;19799.208031678732;20571.38285851425;20717.792822071773;21028.264010759627;20515;20534.17863285467;21248.256311029116;21469.355919322406;21497.892510537466;5907.881842363161;6063.18147050147;6070;6122.326544080148;6138.938610613882;5796.159556864252;6055.122007308938;6070.848228794293;6078.908816367758;6080.878382432349;6008.759649614032;6017.669028203447;6031.125486804411;6033.818985430422;6039.969800151015;5725.541956643479;6022.457978781908;6030.366811484819;6033.064874944391;6036.3661815509395;5144.202648589475;5173.094708426011;5181.481851814826;5185.299984502081;5186.325777648919;24151.792410379585;25209.747902520925;25401.872990635115;25849;25849.741502584922;1894.6305470433272;2198.098779500413;2234.184522649238;2240.9630191522956;2318.7449380568123;14486.34811433488;14663.120212787268;14806.70386592273;14992.325345359484;15166.772498412533;1683.2173039536551;1735.2364959417941;1750.1599232368408;1760.4718584424622;1787.9195436205403;71239.64380178117;78960.60519697423;89098.66352004725;100407;105299;8804.339674524308;10432.74807023147;10530.36817790935;10679.14566834667;10743.14054875608;9859.26055545837;12280.508779648713;12536.435860386304;12747.490100396066;12832.55086071983;8593.355498337649;8669;8732.563371831384;8795.384323097322;8796.516191609522;8999.460032398078;9004.59479323432;9007.459552426875;9017.09829017093;9127.497987610612;6313.747450102036;6425.871482570323;6443.387878151568;6443.7744678936015;6478.319776423502;1557.711823312668;1832.1755210155484;1897.5957791234387;1898.0984032584688;1903.486058764126;849.0405841399303;923.7459698582809;933.8645896344992;935.4340623922565;939.5677988125539;19252.711209331872;21105;21171;21230.04464799088;21430.892845535673;933.4865823796885;970.2916870684439;1002.0530598584268;1046.795874804406;1063.3779239145033;11342.659720208407;11345.376004319842;11368.732241037445;11476;11518.596849110241;535605;563268;576868.2313176899;634065;644619;102894;104769;105745;106197;106327;876.8509353409936;1065.9413732244645;1082.4912291223113;1085.7014321061613;1090.547422819537;18096.366627167987;18422.631591996414;18980.71528927095;19090.904545477184;19175.424737257905;36244.81877590595;48113;50020.74989625029;53436.465635344706;54253.72873135609;57038.42961570331;64052.35947640464;64689.67655161694;65311.69376612346;65628.01557976539;7572.432067594842;7643.503172293783;7699.26856948589;7819.100803407453;7987.600619968862;10214.438205898747;10545.31455455393;11404.429778511207;11766.82349764737;12003.459844306852;9374.531273436165;9952.651657191964;10465.406544249166;10738.140948723927;10837.566497340018;10006.249531285037;10281.588736450458;10358.792824143626;10650.8402373966;10915.345079295268;9260.768480788034;10742.462876856282;10750.193735469715;10871.51078201467;10964.958328958735;7604.657790399335;7616.200298968529;7855.096663883726;7860.0960889496155;8123.309518690741;9510.429374237568;10455.790884182426;10512.369257844553;10848.077913377136;10877.075448586642 05:27:35 INFO - PROCESS | 1663 | |3;mootools.html;1451.1800832529614;1602.5112340736075;1627.6012376967642;1946.2798764457143;2068.245090541952;7929.524228546284;8626.008009078958;8763.298936085113;8785.42894711844;8788.78028049299;8548.273396761268;8752.562371881397;8757.168069033447;8767.47395156291;8768.649254029848;2184.8798316092607;2420.6490058941445;2472.5425796227664;2490.5267999080115;2496.500699860026;2074.305107788885;2479.665245191903;2489.2283392148493;2489.9253022409357;2501.8874150663173;2402.195264586357;2433.9634905476432;2473.938151546208;2478.368016155887;2489.2781093482868;2424.91512797053;2465.2234546118007;2467.9629805553022;2478.5910324796387;2484.5155194737035;2455.287966489716;2481.6525686403916;2492.8255022148455;2494.8128890333296;2509.7113831909382;8849.823003539957;8925.642974281021;8930.464172149692;8940.240079593243;8942.910570894337;5412.91880621791;5544.112941929272;5582.888342233133;5592.496675299202;5599.076152434844;3558.395072837598;3696.537932758405;3707.1473561080834;3747.2505498900327;3748.475213470116;1042.3016578892084;1054.5149231353587;1055.857459243;1071.2929466552039;1073.9087177589913;11909.464074116599;11924.940375298154;11936.40317984106;11941.880581194164;11954.641360759191;4896.387951506062;4938.333325001151;4995.425526064477;5022.799088036438;5044.848654540369;10164.695059148238;10170.745731356626;10172.237082218864;10176.745581360525;10204.183665306758;5509.090999984957;5516.007118718589;5551.056320425538;5551.195076713854;5552.7778888843995;4426.955730442654;4584.15193189261;4803.855884323476;4955.281484184773;4955.554000140005;3857.7492462989817;3945.9605403946166;3959.6436320730695;3982.9601703983167;4010.498687664042;1107.8836722144058;1301.4208677138583;1317.2162563274835;1325.1320385147744;1336.0781061068026;1336.4988129451456;1377.0635967541966;1378.5726424808342;1405.6204824697274;1416.1856932263784;8136.796580085545;8323.209295117076;8328;8330.375221858385;8351.791205219919;506.87834919619024;509.30909380855945;514.3750343332869;516.3519782672722;531.6225479909231;6194.721237544321;6199.318075011745;6244.75020999164;6249.25008998923;6250.6874656267;10317.071463568314;10676.572937082585;10785.514651840529;10788.190885683605;10789.56841726338;10450.216233782498;10503.474826258656;10572.735681607868;10648.361098334124;10666.253362264568;8221.54781487024;8309.709160179365;8311.709090181694;8334.874976875351;8381.245687887997;7801.531908085533;7876.684932602631;7894.644740986554;7913.3669306456495;7942.602869856369;9431.57557909882;9498.335116541775;9507.239420846454;9549.99725028862;9564.426134431957;9573;9831.705048848546;9863.408195508293;9893.752656183653;10030.197584193102;6716.361945615159;6922.480813938874;7354.742584009534;7544.773656790305;7581.052368453943;8194.672213111648;8253.752387428387;8279.379046571652;8281.420300578902;8281.54451505173;7244.710211591478;7393.223711510214;7407;7448.255174482509;7579.848403031799;7283.453740969554;7305.525140865827;7308.378787802883;7346.742863999734;7371.41028717712;7735.955645987719;7741.806454838674;7781.416393770377;7794.4543881929985;7795.883061754192;6987;7001.0198572198915;7057.752978645723;7060.117485314336;7070.469714771516;7096.503244772816;7121.14546254432;7171.1753148386515;7173.390261827803;7174.174969878531 05:27:35 INFO - PROCESS | 1663 | |4;prototype.html;327.46786471983023;332.5709834313735;335.66265902767714;337.959444866616;341.1964822842207;6533.738650453988;6565.638889861056;6604.801855944317;6609.504287178463;6618.040384144296;6563.6061836289855;6585.769498067569;6589.868202635957;6591.835204119888;6611.834704132399;4706.623470122382;4797.208460603996;4822.276658501235;4902.558769710726;4970.080535100999;3952.861649842256;4347.3261644445165;4593.471750748657;4935.975320123394;4936.925946110811;4899.069176856404;4900.730459824708;4912.631552633549;4914.606831453475;4915;4648.767561621922;4724.480307166209;4754.00165965146;4760.024195040009;4764.952350476486;4158.500979882433;4159.230542349675;4168.895777605584;4172.228137794517;4173.895652608679;6189.814305570795;6236.314005459396;6280.874382512324;6302.936970630327;6320;5744.195812586241;5759.107338362561;5761.769529218826;5770.076787713946;5785.2189954356045;6703.396694297537;6932.202796678345;6948.548344357651;6962.094927659423;6971.755988540377;4646.558576935186;4673.5793778559755;4677.4620918594455;4681.2744024675885;4688.273317635738;5581.776728930838;6879.484038697117;7348.265173482609;7359;7370.557766534025;4198.433211516406;4753.04939012199;4758.333833263346;4762.547557982056;4778.689385190021;3953.9324382416585;4825.30033145192;4825.420949486084;4825.662203645781;4827.227643577011;4605.723656580616;5679.31848178213;5684.37471878093;5691.146328050742;5700.800471983461;6702.564333318319;6956.79129626112;7018.227994920555;7066.258042905523;7084.149902011792;1614.8950318229276;1618.401191559107;1639.3688429954552;1639.5163426789127;1640.8769342299374;890.9643614255486;1041.729150420896;1053.0417320238546;1056.4242487844144;1060.750723579958;5447.210154527651;6602.735890564323;6716.798496045127;6735;6746;7178.282171782885;7262.128544574685;7274.854502910018;7379.298966598165;7386.667599958015;6765.391114799691;6773.45812335012;6777.661116944133;6781.491388145909;6781.796546103625;3848;3886.805659717003;3889.4943657324934;3890.3969884667354;3900.90247743803;7355.59544225062;7603.125640551297;7605.23947605235;7673;7745.612719364122;6118.265808102967;6246.750129994749;7479.887801682979;7587.975623290896;7598.620068996528;7703.499272547267;7709.730159444504;7711.383089352838;7715.151333353327;7726.1501234863;6014.097885317237;6950.756723514653;7358.816029599303;7366.96316518414;7369.926300736924;6450.322716114741;6686.966565167143;6902.827429314107;7218.530795498275;7230.204677485367;7622.047244094489;7651.579163145858;7669.88495172584;7676.385889128745;7680.270374314431;4584.014436896084;4646.488886222445;4650;4658.277966915133;4680.555347242007;5889.411058894248;7290.635468226674;7298.416126709957;7307.634618269171;7316.926830731837;5638.5771067170945;6803.25164231944;7057.50597458173;7059.258777828254;7062.1878483975;6971.163460384786;7024.789256322319;7037.1555413350725;7040.964795175992;7044.894326585208;6859.451243900576;6866.622335771581;6874.175098988154;6876.724931002704;6882;6388.776392826228;6791.573769508459;7016.8949315206255;7058.364747172779;7060.752873649398;5764.193012978102;6627.304133065959;6678.732850686112;6679.398854103154;6733 05:27:35 INFO - PROCESS | 1663 | |5;yui.html;681.1485642946316;694.9235584085753;755.4485225785177;767.263427109974;788.4599049650993;15066.623334416632;15257;15257.618559536017;15262.847371526295;15264.618384540392;14012.78980815286;14071.366788494517;14082.57752267431;14140.363683634236;14156.150630962124;593.2850914647839;722.1731117870036;888.2183678363032;889.9777505562348;899.3120262998794;725.4015437264252;731.9670614822346;735.0260904301795;877.4296707140346;906.4470672889532;954.3701157236226;962.6053318139565;969.3263182088451;971.1647982734843;974.468914441631;863.343858667411;958.9232861371108;971.4511301114918;971.6453494474501;972.0959507657875;561.1162419189792;683.7128406069463;708.1997343002425;715.5742333311671;716.5306724095674;14888.404463821435;14936.178510181935;14942;14951.252437378087;14958.476453324081;12384.690382740413;12526.937365313206;12579;12598.874011259863;12834.743305133845;9870.2103831694;9870.60517579296;9951.303408761389;10021.148202402732;10280.485975701185;3468.9653103468895;3546.7871927684423;3565.750397472178;3627.7097832173627;3643.599204087548;79540.20459795385;79659;79778.20221797707;79948.20051799466;80448.59775701084;8203.343732501386;9575.712728618153;9763.755906102404;9771.316007879523;9868.259880508991;21831.12675492994;22112.557748844934;22123.668144977837;22151.889240553694;22167;7254.093238345207;7417.184109747924;7436.40508759298;7558.093028836574;7740;4015.437838702584;4039.9596004040172;4048.4736984192455;4049.534303555129;4060.7766572838186;3695.224002959355;3732.79469629173;3733.141377483194;3733.4959780429836;3736.23407201523;679.2528218959105;680.8468094678658;686.2794066230438;702.9824254393681;703.050881310227;443.33942425785347;544.9673019618835;557.2338035201598;572.516223790896;596.0552524249027;6938.653067346612;7826.3452304341145;8000.959995199987;8157.388195885333;8304.335653147733;574.1018484490264;582.1965687351428;610.3896103896104;615.6952308607268;638.2054342343719;3296.241864371208;3561.8753343632848;3753.230587729509;3793.7534060286544;3836.635519625631;78147.70187639735;78403.86384544669;88945.81378608459;89540;97883.51058244663;56786.432135678115;77166;77532.61233693908;77709.44581108459;78105;69997.95003074958;70843.64578176974;70998;71623;71783.64108179425;8123.4313598047565;8147.837043258983;8160.428769986044;8305.792355190926;8532.829343413221;48504.27243591278;50670.23994640157;51583.742081289354;51696.48303517067;51946.740266298424;51627.74186129045;56508.43491565196;69387.95918061132;72919;73376.26623733908;11059.778804423706;11277.32336059839;11353.886461135284;11392.031677307521;11469.369184694922;11896.583619573274;11915.285082895054;12189;13020.218786872818;13155.473781049033;11395.715107122056;11485.655430337103;11528.962393384636;11561.710957226136;12218.20581662189;11324.886751132382;11333.376664283214;11510.36692981894;11614.477348519167;11758.00056995165;11168.497417616389;11409.60066397672;11411.828822567502;11461.426928653367;11607.739823768365;9680.806383872143;9708.563114659715;9894.356866803635;10055.39667619916;10402.167826574007;8796.868046979429;8871.467711937305;9074.546272686472;9190.954045229731;9711.757206069622 05:27:35 INFO - PROCESS | 1663 | __end_tp_report 05:27:35 INFO - PROCESS | 1663 | __start_cc_report 05:27:35 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1057 05:27:35 INFO - PROCESS | 1663 | __end_cc_report 05:27:35 INFO - PROCESS | 1663 | __startTimestamp1458044855349__endTimestamp 05:27:35 INFO - PROCESS | 1663 | 05:27:35 INFO - PROCESS | 1663 | ------- Summary: start ------- 05:27:35 INFO - PROCESS | 1663 | Number of tests: 6 05:27:35 INFO - PROCESS | 1663 | 05:27:35 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5605.44 Median:5733.71 stddev:618.74 (10.8%) stddev-sans-first:595.99 05:27:35 INFO - PROCESS | 1663 | Values: 3401.5 3481.0 3488.2 3513.5 3544.4 5500.3 5567.9 5575.2 5582.9 5588.4 5571.9 5609.3 5627.2 5733.7 5735.9 5029.5 5064.0 5072.0 5097.8 5182.1 5182.8 5186.6 5218.3 5241.5 5265.5 5029.9 5044.5 5105.5 5126.1 5158.6 5141.0 5145.1 5154.7 5156.3 5186.6 5070.4 5085.7 5108.3 5120.7 5137.7 5368.5 5470.5 5475.5 5481.5 5562.0 4982.3 6075.9 6117.3 6125.7 6132.5 6095.7 6149.4 6162.5 6169.0 6174.8 5594.5 5685.3 5687.9 5691.4 5696.5 6054.7 6108.4 6161.8 6162.9 6164.6 5971.2 6049.7 6067.7 6079.0 6098.6 6052.8 6169.1 6169.2 6180.2 6207.6 5610.8 6017.7 6089.5 6127.1 6129.4 4955.4 6103.7 6123.5 6131.7 6145.8 4800.1 4801.1 4807.6 4816.2 4849.6 4197.8 4274.6 4341.1 4355.3 4374.1 5600.3 5644.5 5655.0 5673.1 5673.7 4946.7 6171.6 6173.0 6174.9 6186.2 5562.6 5612.6 5666.0 5725.1 5750.6 5253.4 5260.0 5265.8 5266.0 5269.9 6079.0 6214.2 6219.5 6233.3 6238.5 5132.6 6069.7 6133.6 6138.2 6188.9 6187.0 6208.1 6246.1 6257.8 6260.4 6012.7 6079.0 6099.6 6106.2 6110.4 6055.2 6066.2 6125.1 6161.7 6184.5 4848.2 5353.7 6009.2 6014.5 6030.6 5944.8 5988.6 5991.7 5993.2 5995.5 4807.6 5579.8 5698.7 5799.0 5920.6 5992.4 5993.2 5995.3 6001.1 6012.9 5793.4 5807.2 5811.1 5823.6 5871.6 05:27:35 INFO - PROCESS | 1663 | 05:27:35 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:59353.77 Median:37041.17 stddev:122461.67 (330.6%) stddev-sans-first:122725.43 05:27:35 INFO - PROCESS | 1663 | Values: 480.5 578.7 580.9 631.7 643.2 38590.4 39431.8 39472.4 39482.2 39647.8 41652.0 42519.5 42599.1 42626.4 42674.8 9323.9 9579.7 9581.9 9584.1 9585.9 9444.8 9575.8 9592.1 9722.6 9757.5 9628.1 9743.3 9749.5 9752.3 9758.3 9663.9 9738.7 9740.1 9742.1 9809.8 9520.5 9628.8 9654.0 9662.9 9665.0 41427.0 41894.4 41913.2 41917.7 41946.4 3279.2 3331.2 3439.6 3722.6 3778.5 28732.6 28740.9 30336.8 30423.5 30462.0 2335.7 2714.4 2714.9 2744.5 2809.2 495117.0 497951.0 499284.0 499562.5 500807.0 45204.1 45696.0 45771.1 45795.0 64607.4 45018.0 45041.5 45139.0 45155.5 45202.8 15732.6 15926.9 15933.5 15966.9 15989.9 12776.7 12848.2 12850.5 12859.6 13003.3 14756.6 14768.1 14770.8 14783.4 14945.4 6466.2 6658.9 6710.2 6716.6 6746.2 1008.1 1013.2 1035.2 1040.6 1086.1 29011.7 29115.3 29188.7 29687.0 29864.0 1078.5 1145.8 1156.2 1208.5 1236.8 14900.4 14946.0 15166.1 15285.5 15332.7 522392.0 528224.0 529844.0 530384.0 530581.0 59812.7 59953.7 60001.7 60152.1 60205.4 1335.0 1460.8 1465.8 1468.4 1492.8 28386.6 29126.6 29440.1 29510.4 30302.2 47832.0 47922.8 48195.0 48196.8 48361.0 326691.0 328654.0 328669.0 328958.0 329031.0 28423.9 32915.5 33279.0 33839.7 33940.8 43038.0 44135.0 44232.8 44433.0 45028.3 35055.8 36320.5 36331.5 37174.4 37384.1 35991.3 36089.5 36701.1 36824.8 36905.8 35722.6 36153.3 36159.6 36233.8 36907.9 31018.8 31653.0 32717.3 35387.0 35643.5 20580.3 23183.0 24664.5 24714.9 25293.7 05:27:35 INFO - PROCESS | 1663 | 05:27:35 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:32847.74 Median:25625.44 stddev:97677.73 (381.2%) stddev-sans-first:97921.28 05:27:35 INFO - PROCESS | 1663 | Values: 364.5 366.1 367.0 375.7 377.7 19515.7 19799.2 20571.4 20717.8 21028.3 20515.0 20534.2 21248.3 21469.4 21497.9 5907.9 6063.2 6070.0 6122.3 6138.9 5796.2 6055.1 6070.8 6078.9 6080.9 6008.8 6017.7 6031.1 6033.8 6040.0 5725.5 6022.5 6030.4 6033.1 6036.4 5144.2 5173.1 5181.5 5185.3 5186.3 24151.8 25209.7 25401.9 25849.0 25849.7 1894.6 2198.1 2234.2 2241.0 2318.7 14486.3 14663.1 14806.7 14992.3 15166.8 1683.2 1735.2 1750.2 1760.5 1787.9 71239.6 78960.6 89098.7 100407.0 105299.0 8804.3 10432.7 10530.4 10679.1 10743.1 9859.3 12280.5 12536.4 12747.5 12832.6 8593.4 8669.0 8732.6 8795.4 8796.5 8999.5 9004.6 9007.5 9017.1 9127.5 6313.7 6425.9 6443.4 6443.8 6478.3 1557.7 1832.2 1897.6 1898.1 1903.5 849.0 923.7 933.9 935.4 939.6 19252.7 21105.0 21171.0 21230.0 21430.9 933.5 970.3 1002.1 1046.8 1063.4 11342.7 11345.4 11368.7 11476.0 11518.6 535605.0 563268.0 576868.2 634065.0 644619.0 102894.0 104769.0 105745.0 106197.0 106327.0 876.9 1065.9 1082.5 1085.7 1090.5 18096.4 18422.6 18980.7 19090.9 19175.4 36244.8 48113.0 50020.7 53436.5 54253.7 57038.4 64052.4 64689.7 65311.7 65628.0 7572.4 7643.5 7699.3 7819.1 7987.6 10214.4 10545.3 11404.4 11766.8 12003.5 9374.5 9952.7 10465.4 10738.1 10837.6 10006.2 10281.6 10358.8 10650.8 10915.3 9260.8 10742.5 10750.2 10871.5 10965.0 7604.7 7616.2 7855.1 7860.1 8123.3 9510.4 10455.8 10512.4 10848.1 10877.1 05:27:35 INFO - PROCESS | 1663 | 05:27:35 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6068.27 Median:2972.27 stddev:3203.43 (107.8%) stddev-sans-first:3193.61 05:27:35 INFO - PROCESS | 1663 | Values: 1451.2 1602.5 1627.6 1946.3 2068.2 7929.5 8626.0 8763.3 8785.4 8788.8 8548.3 8752.6 8757.2 8767.5 8768.6 2184.9 2420.6 2472.5 2490.5 2496.5 2074.3 2479.7 2489.2 2489.9 2501.9 2402.2 2434.0 2473.9 2478.4 2489.3 2424.9 2465.2 2468.0 2478.6 2484.5 2455.3 2481.7 2492.8 2494.8 2509.7 8849.8 8925.6 8930.5 8940.2 8942.9 5412.9 5544.1 5582.9 5592.5 5599.1 3558.4 3696.5 3707.1 3747.3 3748.5 1042.3 1054.5 1055.9 1071.3 1073.9 11909.5 11924.9 11936.4 11941.9 11954.6 4896.4 4938.3 4995.4 5022.8 5044.8 10164.7 10170.7 10172.2 10176.7 10204.2 5509.1 5516.0 5551.1 5551.2 5552.8 4427.0 4584.2 4803.9 4955.3 4955.6 3857.7 3946.0 3959.6 3983.0 4010.5 1107.9 1301.4 1317.2 1325.1 1336.1 1336.5 1377.1 1378.6 1405.6 1416.2 8136.8 8323.2 8328.0 8330.4 8351.8 506.9 509.3 514.4 516.4 531.6 6194.7 6199.3 6244.8 6249.3 6250.7 10317.1 10676.6 10785.5 10788.2 10789.6 10450.2 10503.5 10572.7 10648.4 10666.3 8221.5 8309.7 8311.7 8334.9 8381.2 7801.5 7876.7 7894.6 7913.4 7942.6 9431.6 9498.3 9507.2 9550.0 9564.4 9573.0 9831.7 9863.4 9893.8 10030.2 6716.4 6922.5 7354.7 7544.8 7581.1 8194.7 8253.8 8279.4 8281.4 8281.5 7244.7 7393.2 7407.0 7448.3 7579.8 7283.5 7305.5 7308.4 7346.7 7371.4 7736.0 7741.8 7781.4 7794.5 7795.9 6987.0 7001.0 7057.8 7060.1 7070.5 7096.5 7121.1 7171.2 7173.4 7174.2 05:27:35 INFO - PROCESS | 1663 | 05:27:35 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5709.69 Median:6564.62 stddev:1821.81 (27.8%) stddev-sans-first:1781.57 05:27:35 INFO - PROCESS | 1663 | Values: 327.5 332.6 335.7 338.0 341.2 6533.7 6565.6 6604.8 6609.5 6618.0 6563.6 6585.8 6589.9 6591.8 6611.8 4706.6 4797.2 4822.3 4902.6 4970.1 3952.9 4347.3 4593.5 4936.0 4936.9 4899.1 4900.7 4912.6 4914.6 4915.0 4648.8 4724.5 4754.0 4760.0 4765.0 4158.5 4159.2 4168.9 4172.2 4173.9 6189.8 6236.3 6280.9 6302.9 6320.0 5744.2 5759.1 5761.8 5770.1 5785.2 6703.4 6932.2 6948.5 6962.1 6971.8 4646.6 4673.6 4677.5 4681.3 4688.3 5581.8 6879.5 7348.3 7359.0 7370.6 4198.4 4753.0 4758.3 4762.5 4778.7 3953.9 4825.3 4825.4 4825.7 4827.2 4605.7 5679.3 5684.4 5691.1 5700.8 6702.6 6956.8 7018.2 7066.3 7084.1 1614.9 1618.4 1639.4 1639.5 1640.9 891.0 1041.7 1053.0 1056.4 1060.8 5447.2 6602.7 6716.8 6735.0 6746.0 7178.3 7262.1 7274.9 7379.3 7386.7 6765.4 6773.5 6777.7 6781.5 6781.8 3848.0 3886.8 3889.5 3890.4 3900.9 7355.6 7603.1 7605.2 7673.0 7745.6 6118.3 6246.8 7479.9 7588.0 7598.6 7703.5 7709.7 7711.4 7715.2 7726.2 6014.1 6950.8 7358.8 7367.0 7369.9 6450.3 6687.0 6902.8 7218.5 7230.2 7622.0 7651.6 7669.9 7676.4 7680.3 4584.0 4646.5 4650.0 4658.3 4680.6 5889.4 7290.6 7298.4 7307.6 7316.9 5638.6 6803.3 7057.5 7059.3 7062.2 6971.2 7024.8 7037.2 7041.0 7044.9 6859.5 6866.6 6874.2 6876.7 6882.0 6388.8 6791.6 7016.9 7058.4 7060.8 5764.2 6627.3 6678.7 6679.4 6733.0 05:27:35 INFO - PROCESS | 1663 | 05:27:35 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:17990.80 Median:603.22 stddev:24935.83 (4133.8%) stddev-sans-first:24971.91 05:27:35 INFO - PROCESS | 1663 | Values: 681.1 694.9 755.4 767.3 788.5 15066.6 15257.0 15257.6 15262.8 15264.6 14012.8 14071.4 14082.6 14140.4 14156.2 593.3 722.2 888.2 890.0 899.3 725.4 732.0 735.0 877.4 906.4 954.4 962.6 969.3 971.2 974.5 863.3 958.9 971.5 971.6 972.1 561.1 683.7 708.2 715.6 716.5 14888.4 14936.2 14942.0 14951.3 14958.5 12384.7 12526.9 12579.0 12598.9 12834.7 9870.2 9870.6 9951.3 10021.1 10280.5 3469.0 3546.8 3565.8 3627.7 3643.6 79540.2 79659.0 79778.2 79948.2 80448.6 8203.3 9575.7 9763.8 9771.3 9868.3 21831.1 22112.6 22123.7 22151.9 22167.0 7254.1 7417.2 7436.4 7558.1 7740.0 4015.4 4040.0 4048.5 4049.5 4060.8 3695.2 3732.8 3733.1 3733.5 3736.2 679.3 680.8 686.3 703.0 703.1 443.3 545.0 557.2 572.5 596.1 6938.7 7826.3 8001.0 8157.4 8304.3 574.1 582.2 610.4 615.7 638.2 3296.2 3561.9 3753.2 3793.8 3836.6 78147.7 78403.9 88945.8 89540.0 97883.5 56786.4 77166.0 77532.6 77709.4 78105.0 69998.0 70843.6 70998.0 71623.0 71783.6 8123.4 8147.8 8160.4 8305.8 8532.8 48504.3 50670.2 51583.7 51696.5 51946.7 51627.7 56508.4 69388.0 72919.0 73376.3 11059.8 11277.3 11353.9 11392.0 11469.4 11896.6 11915.3 12189.0 13020.2 13155.5 11395.7 11485.7 11529.0 11561.7 12218.2 11324.9 11333.4 11510.4 11614.5 11758.0 11168.5 11409.6 11411.8 11461.4 11607.7 9680.8 9708.6 9894.4 10055.4 10402.2 8796.9 8871.5 9074.5 9191.0 9711.8 05:27:35 INFO - PROCESS | 1663 | -------- Summary: end -------- 05:27:35 INFO - PROCESS | 1663 | 05:27:35 INFO - TEST-INFO | 1663: exit 0 05:27:35 INFO - TEST-OK | dromaeo_css | took 1113762ms 05:27:35 INFO - TEST-START | kraken 05:27:35 INFO - operating with platform_type : mac_ 05:27:35 INFO - Initialising browser for kraken test... 05:27:35 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmphba8MG/profile http://localhost:49271/getInfo.html) 05:27:38 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 05:27:38 INFO - PROCESS | 1669 | colorDepth:24 05:27:38 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 05:27:38 INFO - PROCESS | 1669 | __metrics 05:27:38 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:27:38 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:27:39 INFO - TEST-INFO | 1669: exit 0 05:27:39 INFO - Browser initialized. 05:27:39 INFO - Running cycle 1/1 for kraken test... 05:27:39 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmphba8MG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:51 INFO - PROCESS | 1671 | RSS: Main: 243200000 05:27:51 INFO - PROCESS | 1671 | 05:27:53 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:54 INFO - PROCESS | 1671 | RSS: Main: 288653312 05:27:54 INFO - PROCESS | 1671 | 05:27:57 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 05:27:57 INFO - PROCESS | 1671 | RSS: Main: 299532288 05:27:57 INFO - PROCESS | 1671 | 05:28:00 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 05:28:01 INFO - PROCESS | 1671 | RSS: Main: 285630464 05:28:01 INFO - PROCESS | 1671 | 05:28:03 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 05:28:03 INFO - PROCESS | 1671 | RSS: Main: 289243136 05:28:03 INFO - PROCESS | 1671 | 05:28:06 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:06 INFO - PROCESS | 1671 | RSS: Main: 289705984 05:28:06 INFO - PROCESS | 1671 | 05:28:09 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:10 INFO - PROCESS | 1671 | RSS: Main: 289189888 05:28:10 INFO - PROCESS | 1671 | 05:28:13 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:13 INFO - PROCESS | 1671 | RSS: Main: 289406976 05:28:13 INFO - PROCESS | 1671 | 05:28:16 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 05:28:17 INFO - PROCESS | 1671 | RSS: Main: 289808384 05:28:17 INFO - PROCESS | 1671 | 05:28:18 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:19 INFO - PROCESS | 1671 | RSS: Main: 325537792 05:28:19 INFO - PROCESS | 1671 | 05:28:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:21 INFO - PROCESS | 1671 | RSS: Main: 323997696 05:28:21 INFO - PROCESS | 1671 | 05:28:23 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:24 INFO - PROCESS | 1671 | RSS: Main: 332070912 05:28:24 INFO - PROCESS | 1671 | 05:28:26 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:27 INFO - PROCESS | 1671 | RSS: Main: 333770752 05:28:27 INFO - PROCESS | 1671 | 05:28:29 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:30 INFO - PROCESS | 1671 | RSS: Main: 333348864 05:28:30 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 05:28:32 INFO - PROCESS | 1671 | RSS: Main: 393261056 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | __start_tp_report 05:28:32 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 05:28:32 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 05:28:32 INFO - PROCESS | 1671 | |i|pagename|runs| 05:28:32 INFO - PROCESS | 1671 | |0;ai-astar;110;107;109;111;117;166;170;110;110;110 05:28:32 INFO - PROCESS | 1671 | |1;audio-beat-detection;161;148;175;157;117;141;140;117;161;116 05:28:32 INFO - PROCESS | 1671 | |2;audio-dft;183;184;187;186;186;184;188;182;179;182 05:28:32 INFO - PROCESS | 1671 | |3;audio-fft;82;72;84;77;60;57;56;77;75;55 05:28:32 INFO - PROCESS | 1671 | |4;audio-oscillator;96;92;128;79;79;85;114;77;80;113 05:28:32 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;87;85;88;85;92;129;116;85;89;85 05:28:32 INFO - PROCESS | 1671 | |6;imaging-darkroom;138;120;94;94;93;93;94;95;97;92 05:28:32 INFO - PROCESS | 1671 | |7;imaging-desaturate;128;135;84;86;84;94;85;87;84;86 05:28:32 INFO - PROCESS | 1671 | |8;json-parse-financial;56;55;54;52;54;53;55;66;56;53 05:28:32 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;63;79;74;76;71;68;66;67;68;69 05:28:32 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;83;81;82;81;83;82;83;79;80;71 05:28:32 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;119;130;133;134;125;120;117;126;130;136 05:28:32 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;158;134;140;138;135;126;139;164;141;135 05:28:32 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;67;67;67;69;88;87;68;67;66;67 05:28:32 INFO - PROCESS | 1671 | __end_tp_report 05:28:32 INFO - PROCESS | 1671 | __start_cc_report 05:28:32 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1280 05:28:32 INFO - PROCESS | 1671 | __end_cc_report 05:28:32 INFO - PROCESS | 1671 | __startTimestamp1458044912552__endTimestamp 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | ------- Summary: start ------- 05:28:32 INFO - PROCESS | 1671 | Number of tests: 14 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:122.00 Median:110.50 stddev:24.39 (22.1%) stddev-sans-first:25.49 05:28:32 INFO - PROCESS | 1671 | Values: 110.0 107.0 109.0 111.0 117.0 166.0 170.0 110.0 110.0 110.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:152.50 stddev:21.05 (13.8%) stddev-sans-first:21.32 05:28:32 INFO - PROCESS | 1671 | Values: 161.0 148.0 175.0 157.0 117.0 141.0 140.0 117.0 161.0 116.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:184.10 Median:185.00 stddev:2.73 (1.5%) stddev-sans-first:2.86 05:28:32 INFO - PROCESS | 1671 | Values: 183.0 184.0 187.0 186.0 186.0 184.0 188.0 182.0 179.0 182.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:69.50 Median:76.00 stddev:11.33 (14.9%) stddev-sans-first:11.07 05:28:32 INFO - PROCESS | 1671 | Values: 82.0 72.0 84.0 77.0 60.0 57.0 56.0 77.0 75.0 55.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:79.50 stddev:18.07 (22.7%) stddev-sans-first:19.16 05:28:32 INFO - PROCESS | 1671 | Values: 96.0 92.0 128.0 79.0 79.0 85.0 114.0 77.0 80.0 113.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:94.10 Median:86.00 stddev:15.44 (18.0%) stddev-sans-first:16.17 05:28:32 INFO - PROCESS | 1671 | Values: 87.0 85.0 88.0 85.0 92.0 129.0 116.0 85.0 89.0 85.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:101.00 Median:94.00 stddev:15.41 (16.4%) stddev-sans-first:8.78 05:28:32 INFO - PROCESS | 1671 | Values: 138.0 120.0 94.0 94.0 93.0 93.0 94.0 95.0 97.0 92.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:85.50 stddev:19.37 (22.7%) stddev-sans-first:16.55 05:28:32 INFO - PROCESS | 1671 | Values: 128.0 135.0 84.0 86.0 84.0 94.0 85.0 87.0 84.0 86.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:3.95 (7.2%) stddev-sans-first:4.18 05:28:32 INFO - PROCESS | 1671 | Values: 56.0 55.0 54.0 52.0 54.0 53.0 55.0 66.0 56.0 53.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:4.91 (7.0%) stddev-sans-first:4.48 05:28:32 INFO - PROCESS | 1671 | Values: 63.0 79.0 74.0 76.0 71.0 68.0 66.0 67.0 68.0 69.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:82.00 stddev:3.60 (4.4%) stddev-sans-first:3.70 05:28:32 INFO - PROCESS | 1671 | Values: 83.0 81.0 82.0 81.0 83.0 82.0 83.0 79.0 80.0 71.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:130.00 stddev:6.68 (5.1%) stddev-sans-first:6.43 05:28:32 INFO - PROCESS | 1671 | Values: 119.0 130.0 133.0 134.0 125.0 120.0 117.0 126.0 130.0 136.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.00 Median:139.50 stddev:11.44 (8.2%) stddev-sans-first:10.35 05:28:32 INFO - PROCESS | 1671 | Values: 158.0 134.0 140.0 138.0 135.0 126.0 139.0 164.0 141.0 135.0 05:28:32 INFO - PROCESS | 1671 | 05:28:32 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:67.50 stddev:8.58 (12.7%) stddev-sans-first:8.96 05:28:32 INFO - PROCESS | 1671 | Values: 67.0 67.0 67.0 69.0 88.0 87.0 68.0 67.0 66.0 67.0 05:28:32 INFO - PROCESS | 1671 | -------- Summary: end -------- 05:28:32 INFO - PROCESS | 1671 | 05:28:33 INFO - TEST-INFO | 1671: exit 0 05:28:33 INFO - TEST-OK | kraken | took 57419ms 05:28:33 INFO - SUITE-END | took 1171s 05:28:33 INFO - Completed test suite (00:19:31) 05:28:33 INFO - javascript benchmark 05:28:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3401.4557670772674, 3481.042713253855, 3488.1977145256574, 3513.4554144107674, 3544.379733546629, 5500.257465242191, 5567.916481252784, 5575.2473416088815, 5582.944170558293, 5588.357338906027, 5571.916421253684, 5609.270794796681, 5627.184058311543, 5733.713314334277, 5735.942640573593, 5029.47190544993, 5063.974680126595, 5072.0, 5097.770600322994, 5182.067227898996, 5182.844514664566, 5186.636935414523, 5218.32161818963, 5241.50205730455, 5265.473452654742, 5029.949700502984, 5044.54599086084, 5105.463926287724, 5126.128558145124, 5158.561522270612, 5141.0232055909255, 5145.125328694131, 5154.716490593016, 5156.278121063054, 5186.611004174664, 5070.416902056237, 5085.720285384303, 5108.335916330853, 5120.743962801882, 5137.717425541631, 5368.516833485005, 5470.480304371078, 5475.4524547544925, 5481.451854814526, 5561.972190139064, 4982.277569752366, 6075.878482430371, 6117.296510901258, 6125.693715314261, 6132.540059495555, 6095.664738439384, 6149.446549810538, 6162.537809664248, 6168.999999999955, 6174.8147555573405, 5594.496495315441, 5685.317761868602, 5687.9431205687415, 5691.430856914276, 5696.51579615729, 6054.727537260834, 6108.35862234459, 6161.84595385119, 6162.907556386658, 6164.568480206342, 5971.164037034819, 6049.727762250709, 6067.7269522871575, 6078.969605151946, 6098.634081955008, 6052.757889684452, 6169.105479705418, 6169.167162433104, 6180.196574445384, 6207.6275423474735, 5610.831675049755, 6017.669028203403, 6089.48239399656, 6127.080937859357, 6129.419919118773, 4955.4301255356095, 6103.725332360054, 6123.4795042421, 6131.713108457284, 6145.784897528565, 4800.1119792838435, 4801.063792560487, 4807.567318941242, 4816.20532612122, 4849.612031037508, 4197.8320867165585, 4274.551172126944, 4341.088371442032, 4355.259605867011, 4374.12517496502, 5600.327960644749, 5644.463775941279, 5655.0103731847585, 5673.0923052312255, 5673.687947162945, 4946.703197808143, 6171.56799024073, 6173.012318029184, 6174.876502469925, 6186.226721659793, 5562.582806289544, 5612.550995920316, 5666.036773748473, 5725.08398656213, 5750.568707346965, 5253.369595648546, 5260.0, 5265.842024739188, 5266.0, 5269.894602108013, 6079.0273556230795, 6214.161088253028, 6219.502439804804, 6233.34549872266, 6238.532110091671, 5132.563732082815, 6069.666168360606, 6133.579501509301, 6138.171346868295, 6188.938110618837, 6187.0, 6208.1308616792785, 6246.125542424155, 6257.780977665942, 6260.40526150015, 6012.6993650316435, 6079.0, 6099.603525770811, 6106.175666284995, 6110.419510146529, 6055.182550355646, 6066.241719785027, 6125.111858780541, 6161.722722477589, 6184.536159787944, 4848.224284114524, 5353.705546194997, 6009.248843894513, 6014.458698717136, 6030.577859549965, 5944.791932282349, 5988.640681559121, 5991.670458124845, 5993.220881285405, 5995.490383317467, 4807.61539076866, 5579.832605021856, 5698.6580805151825, 5799.014167591436, 5920.615160014758, 5992.43071908168, 5993.160957465871, 5995.340512543704, 6001.129836173643, 6012.909806352821, 5793.36273009977, 5807.186993820784, 5811.128330750421, 5823.621464604787, 5871.6183448075735], "unit": "score", "name": "dojo.html", "value": 5570.038500942202}, {"lowerIsBetter": false, "replicates": [480.5410832654815, 578.6556998585843, 580.9448102430271, 631.7125707802952, 643.2474005413666, 38590.421143682834, 39431.80284098582, 39472.40791388132, 39482.2103557929, 39647.801760991155, 41652.0, 42519.51181708641, 42599.14801703972, 42626.360604590955, 42674.78662606682, 9323.860142097858, 9579.712608621718, 9581.90418095817, 9584.137427631547, 9585.856212156823, 9444.81110377792, 9575.808483830318, 9592.08875156859, 9722.611095556169, 9757.512124393787, 9628.13346798788, 9743.317967742261, 9749.512524373788, 9752.268579856503, 9758.316917815755, 9663.855042174338, 9738.707838764849, 9740.074692904163, 9742.07450292221, 9809.754756131082, 9520.476373799438, 9628.759281017961, 9654.0, 9662.855057174149, 9664.95167524165, 41427.0, 41894.371584426255, 41913.16173676509, 41917.74246772602, 41946.37080443796, 3279.212988882651, 3331.233816222258, 3439.5872495300473, 3722.6091260417807, 3778.4710140580064, 28732.569011464635, 28740.850365985334, 30336.84831575828, 30423.543646845315, 30462.0, 2335.6963594732747, 2714.429969706364, 2714.904978325749, 2744.547149720294, 2809.1993781772303, 495117.0, 497951.0, 499284.0, 499562.50218749035, 500807.0, 45204.095918082116, 45696.0, 45771.08457830825, 45795.0, 64607.353926460135, 45018.0, 45041.54958450439, 45139.0, 45155.54844451579, 45202.77398612986, 15732.60668483297, 15926.920365398099, 15933.521994340188, 15966.920165399099, 15989.920050399674, 12776.6805829855, 12848.229106253655, 12850.485980560672, 12859.614211573667, 13003.349832508336, 14756.63108422298, 14768.113913165245, 14770.778438323434, 14783.408663653334, 14945.402183912522, 6466.191726034246, 6658.935729923739, 6710.1947766267385, 6716.630585317756, 6746.156730408699, 1008.0927165551062, 1013.2350075692952, 1035.1822060572215, 1040.635777477892, 1086.1419478611965, 29011.709882901323, 29115.27211819679, 29188.708112918597, 29687.0, 29863.95476158324, 1078.5362294213564, 1145.7536629624672, 1156.2022204678913, 1208.456194712383, 1236.814477828315, 14900.403983840743, 14945.953783235069, 15166.090034597959, 15285.465008724641, 15332.693346133015, 522392.0, 528224.0, 529844.0, 530384.0, 530581.0, 59812.700936495035, 59953.700231498566, 60001.699991499765, 60152.097718534256, 60205.39794601998, 1335.0, 1460.8173978252719, 1465.7581499052537, 1468.4419920430169, 1492.7835463857898, 28386.574201386582, 29126.56310155307, 29440.11679649614, 29510.409791803613, 30302.242443938198, 47832.0, 47922.76038619784, 48195.0, 48196.7590162047, 48361.0, 326691.0, 328654.0, 328669.0, 328958.0, 329031.0, 28423.857880710464, 32915.50626740649, 33279.0, 33839.66160338464, 33940.83029584836, 43038.0, 44135.0, 44232.778836105615, 44433.0, 45028.32457513206, 35055.82472087623, 36320.4551931716, 36331.45502817513, 37174.44238336481, 37384.06539836526, 35991.28017439584, 36089.458658120675, 36701.08247293839, 36824.81587592152, 36905.81547092248, 35722.64277357193, 36153.276934460635, 36159.63840361563, 36233.81883090568, 36907.89276321715, 31018.844905775328, 31653.0, 32717.345653087283, 35387.0, 35643.46534802032, 20580.25067869188, 23183.0, 24664.506709866062, 24714.876425617756, 25293.747062529874], "unit": "score", "name": "ext.html", "value": 19105.773992055274}, {"lowerIsBetter": false, "replicates": [364.5206553382302, 366.0555766123402, 366.99633003669953, 375.6656575647674, 377.7185996432658, 19515.70726439103, 19799.208031678732, 20571.38285851425, 20717.792822071773, 21028.264010759627, 20515.0, 20534.17863285467, 21248.256311029116, 21469.355919322406, 21497.892510537466, 5907.881842363161, 6063.18147050147, 6070.0, 6122.326544080148, 6138.938610613882, 5796.159556864252, 6055.122007308938, 6070.848228794293, 6078.908816367758, 6080.878382432349, 6008.759649614032, 6017.669028203447, 6031.125486804411, 6033.818985430422, 6039.969800151015, 5725.541956643479, 6022.457978781908, 6030.366811484819, 6033.064874944391, 6036.3661815509395, 5144.202648589475, 5173.094708426011, 5181.481851814826, 5185.299984502081, 5186.325777648919, 24151.792410379585, 25209.747902520925, 25401.872990635115, 25849.0, 25849.741502584922, 1894.6305470433272, 2198.098779500413, 2234.184522649238, 2240.9630191522956, 2318.7449380568123, 14486.34811433488, 14663.120212787268, 14806.70386592273, 14992.325345359484, 15166.772498412533, 1683.2173039536551, 1735.2364959417941, 1750.1599232368408, 1760.4718584424622, 1787.9195436205403, 71239.64380178117, 78960.60519697423, 89098.66352004725, 100407.0, 105299.0, 8804.339674524308, 10432.74807023147, 10530.36817790935, 10679.14566834667, 10743.14054875608, 9859.26055545837, 12280.508779648713, 12536.435860386304, 12747.490100396066, 12832.55086071983, 8593.355498337649, 8669.0, 8732.563371831384, 8795.384323097322, 8796.516191609522, 8999.460032398078, 9004.59479323432, 9007.459552426875, 9017.09829017093, 9127.497987610612, 6313.747450102036, 6425.871482570323, 6443.387878151568, 6443.7744678936015, 6478.319776423502, 1557.711823312668, 1832.1755210155484, 1897.5957791234387, 1898.0984032584688, 1903.486058764126, 849.0405841399303, 923.7459698582809, 933.8645896344992, 935.4340623922565, 939.5677988125539, 19252.711209331872, 21105.0, 21171.0, 21230.04464799088, 21430.892845535673, 933.4865823796885, 970.2916870684439, 1002.0530598584268, 1046.795874804406, 1063.3779239145033, 11342.659720208407, 11345.376004319842, 11368.732241037445, 11476.0, 11518.596849110241, 535605.0, 563268.0, 576868.2313176899, 634065.0, 644619.0, 102894.0, 104769.0, 105745.0, 106197.0, 106327.0, 876.8509353409936, 1065.9413732244645, 1082.4912291223113, 1085.7014321061613, 1090.547422819537, 18096.366627167987, 18422.631591996414, 18980.71528927095, 19090.904545477184, 19175.424737257905, 36244.81877590595, 48113.0, 50020.74989625029, 53436.465635344706, 54253.72873135609, 57038.42961570331, 64052.35947640464, 64689.67655161694, 65311.69376612346, 65628.01557976539, 7572.432067594842, 7643.503172293783, 7699.26856948589, 7819.100803407453, 7987.600619968862, 10214.438205898747, 10545.31455455393, 11404.429778511207, 11766.82349764737, 12003.459844306852, 9374.531273436165, 9952.651657191964, 10465.406544249166, 10738.140948723927, 10837.566497340018, 10006.249531285037, 10281.588736450458, 10358.792824143626, 10650.8402373966, 10915.345079295268, 9260.768480788034, 10742.462876856282, 10750.193735469715, 10871.51078201467, 10964.958328958735, 7604.657790399335, 7616.200298968529, 7855.096663883726, 7860.0960889496155, 8123.309518690741, 9510.429374237568, 10455.790884182426, 10512.369257844553, 10848.077913377136, 10877.075448586642], "unit": "score", "name": "jquery.html", "value": 9382.157762665563}, {"lowerIsBetter": false, "replicates": [1451.1800832529614, 1602.5112340736075, 1627.6012376967642, 1946.2798764457143, 2068.245090541952, 7929.524228546284, 8626.008009078958, 8763.298936085113, 8785.42894711844, 8788.78028049299, 8548.273396761268, 8752.562371881397, 8757.168069033447, 8767.47395156291, 8768.649254029848, 2184.8798316092607, 2420.6490058941445, 2472.5425796227664, 2490.5267999080115, 2496.500699860026, 2074.305107788885, 2479.665245191903, 2489.2283392148493, 2489.9253022409357, 2501.8874150663173, 2402.195264586357, 2433.9634905476432, 2473.938151546208, 2478.368016155887, 2489.2781093482868, 2424.91512797053, 2465.2234546118007, 2467.9629805553022, 2478.5910324796387, 2484.5155194737035, 2455.287966489716, 2481.6525686403916, 2492.8255022148455, 2494.8128890333296, 2509.7113831909382, 8849.823003539957, 8925.642974281021, 8930.464172149692, 8940.240079593243, 8942.910570894337, 5412.91880621791, 5544.112941929272, 5582.888342233133, 5592.496675299202, 5599.076152434844, 3558.395072837598, 3696.537932758405, 3707.1473561080834, 3747.2505498900327, 3748.475213470116, 1042.3016578892084, 1054.5149231353587, 1055.857459243, 1071.2929466552039, 1073.9087177589913, 11909.464074116599, 11924.940375298154, 11936.40317984106, 11941.880581194164, 11954.641360759191, 4896.387951506062, 4938.333325001151, 4995.425526064477, 5022.799088036438, 5044.848654540369, 10164.695059148238, 10170.745731356626, 10172.237082218864, 10176.745581360525, 10204.183665306758, 5509.090999984957, 5516.007118718589, 5551.056320425538, 5551.195076713854, 5552.7778888843995, 4426.955730442654, 4584.15193189261, 4803.855884323476, 4955.281484184773, 4955.554000140005, 3857.7492462989817, 3945.9605403946166, 3959.6436320730695, 3982.9601703983167, 4010.498687664042, 1107.8836722144058, 1301.4208677138583, 1317.2162563274835, 1325.1320385147744, 1336.0781061068026, 1336.4988129451456, 1377.0635967541966, 1378.5726424808342, 1405.6204824697274, 1416.1856932263784, 8136.796580085545, 8323.209295117076, 8328.0, 8330.375221858385, 8351.791205219919, 506.87834919619024, 509.30909380855945, 514.3750343332869, 516.3519782672722, 531.6225479909231, 6194.721237544321, 6199.318075011745, 6244.75020999164, 6249.25008998923, 6250.6874656267, 10317.071463568314, 10676.572937082585, 10785.514651840529, 10788.190885683605, 10789.56841726338, 10450.216233782498, 10503.474826258656, 10572.735681607868, 10648.361098334124, 10666.253362264568, 8221.54781487024, 8309.709160179365, 8311.709090181694, 8334.874976875351, 8381.245687887997, 7801.531908085533, 7876.684932602631, 7894.644740986554, 7913.3669306456495, 7942.602869856369, 9431.57557909882, 9498.335116541775, 9507.239420846454, 9549.99725028862, 9564.426134431957, 9573.0, 9831.705048848546, 9863.408195508293, 9893.752656183653, 10030.197584193102, 6716.361945615159, 6922.480813938874, 7354.742584009534, 7544.773656790305, 7581.052368453943, 8194.672213111648, 8253.752387428387, 8279.379046571652, 8281.420300578902, 8281.54451505173, 7244.710211591478, 7393.223711510214, 7407.0, 7448.255174482509, 7579.848403031799, 7283.453740969554, 7305.525140865827, 7308.378787802883, 7346.742863999734, 7371.41028717712, 7735.955645987719, 7741.806454838674, 7781.416393770377, 7794.4543881929985, 7795.883061754192, 6987.0, 7001.0198572198915, 7057.752978645723, 7060.117485314336, 7070.469714771516, 7096.503244772816, 7121.14546254432, 7171.1753148386515, 7173.390261827803, 7174.174969878531], "unit": "score", "name": "mootools.html", "value": 4871.658358638609}, {"lowerIsBetter": false, "replicates": [327.46786471983023, 332.5709834313735, 335.66265902767714, 337.959444866616, 341.1964822842207, 6533.738650453988, 6565.638889861056, 6604.801855944317, 6609.504287178463, 6618.040384144296, 6563.6061836289855, 6585.769498067569, 6589.868202635957, 6591.835204119888, 6611.834704132399, 4706.623470122382, 4797.208460603996, 4822.276658501235, 4902.558769710726, 4970.080535100999, 3952.861649842256, 4347.3261644445165, 4593.471750748657, 4935.975320123394, 4936.925946110811, 4899.069176856404, 4900.730459824708, 4912.631552633549, 4914.606831453475, 4915.0, 4648.767561621922, 4724.480307166209, 4754.00165965146, 4760.024195040009, 4764.952350476486, 4158.500979882433, 4159.230542349675, 4168.895777605584, 4172.228137794517, 4173.895652608679, 6189.814305570795, 6236.314005459396, 6280.874382512324, 6302.936970630327, 6320.0, 5744.195812586241, 5759.107338362561, 5761.769529218826, 5770.076787713946, 5785.2189954356045, 6703.396694297537, 6932.202796678345, 6948.548344357651, 6962.094927659423, 6971.755988540377, 4646.558576935186, 4673.5793778559755, 4677.4620918594455, 4681.2744024675885, 4688.273317635738, 5581.776728930838, 6879.484038697117, 7348.265173482609, 7359.0, 7370.557766534025, 4198.433211516406, 4753.04939012199, 4758.333833263346, 4762.547557982056, 4778.689385190021, 3953.9324382416585, 4825.30033145192, 4825.420949486084, 4825.662203645781, 4827.227643577011, 4605.723656580616, 5679.31848178213, 5684.37471878093, 5691.146328050742, 5700.800471983461, 6702.564333318319, 6956.79129626112, 7018.227994920555, 7066.258042905523, 7084.149902011792, 1614.8950318229276, 1618.401191559107, 1639.3688429954552, 1639.5163426789127, 1640.8769342299374, 890.9643614255486, 1041.729150420896, 1053.0417320238546, 1056.4242487844144, 1060.750723579958, 5447.210154527651, 6602.735890564323, 6716.798496045127, 6735.0, 6746.0, 7178.282171782885, 7262.128544574685, 7274.854502910018, 7379.298966598165, 7386.667599958015, 6765.391114799691, 6773.45812335012, 6777.661116944133, 6781.491388145909, 6781.796546103625, 3848.0, 3886.805659717003, 3889.4943657324934, 3890.3969884667354, 3900.90247743803, 7355.59544225062, 7603.125640551297, 7605.23947605235, 7673.0, 7745.612719364122, 6118.265808102967, 6246.750129994749, 7479.887801682979, 7587.975623290896, 7598.620068996528, 7703.499272547267, 7709.730159444504, 7711.383089352838, 7715.151333353327, 7726.1501234863, 6014.097885317237, 6950.756723514653, 7358.816029599303, 7366.96316518414, 7369.926300736924, 6450.322716114741, 6686.966565167143, 6902.827429314107, 7218.530795498275, 7230.204677485367, 7622.047244094489, 7651.579163145858, 7669.88495172584, 7676.385889128745, 7680.270374314431, 4584.014436896084, 4646.488886222445, 4650.0, 4658.277966915133, 4680.555347242007, 5889.411058894248, 7290.635468226674, 7298.416126709957, 7307.634618269171, 7316.926830731837, 5638.5771067170945, 6803.25164231944, 7057.50597458173, 7059.258777828254, 7062.1878483975, 6971.163460384786, 7024.789256322319, 7037.1555413350725, 7040.964795175992, 7044.894326585208, 6859.451243900576, 6866.622335771581, 6874.175098988154, 6876.724931002704, 6882.0, 6388.776392826228, 6791.573769508459, 7016.8949315206255, 7058.364747172779, 7060.752873649398, 5764.193012978102, 6627.304133065959, 6678.732850686112, 6679.398854103154, 6733.0], "unit": "score", "name": "prototype.html", "value": 5103.867899343016}, {"lowerIsBetter": false, "replicates": [681.1485642946316, 694.9235584085753, 755.4485225785177, 767.263427109974, 788.4599049650993, 15066.623334416632, 15257.0, 15257.618559536017, 15262.847371526295, 15264.618384540392, 14012.78980815286, 14071.366788494517, 14082.57752267431, 14140.363683634236, 14156.150630962124, 593.2850914647839, 722.1731117870036, 888.2183678363032, 889.9777505562348, 899.3120262998794, 725.4015437264252, 731.9670614822346, 735.0260904301795, 877.4296707140346, 906.4470672889532, 954.3701157236226, 962.6053318139565, 969.3263182088451, 971.1647982734843, 974.468914441631, 863.343858667411, 958.9232861371108, 971.4511301114918, 971.6453494474501, 972.0959507657875, 561.1162419189792, 683.7128406069463, 708.1997343002425, 715.5742333311671, 716.5306724095674, 14888.404463821435, 14936.178510181935, 14942.0, 14951.252437378087, 14958.476453324081, 12384.690382740413, 12526.937365313206, 12579.0, 12598.874011259863, 12834.743305133845, 9870.2103831694, 9870.60517579296, 9951.303408761389, 10021.148202402732, 10280.485975701185, 3468.9653103468895, 3546.7871927684423, 3565.750397472178, 3627.7097832173627, 3643.599204087548, 79540.20459795385, 79659.0, 79778.20221797707, 79948.20051799466, 80448.59775701084, 8203.343732501386, 9575.712728618153, 9763.755906102404, 9771.316007879523, 9868.259880508991, 21831.12675492994, 22112.557748844934, 22123.668144977837, 22151.889240553694, 22167.0, 7254.093238345207, 7417.184109747924, 7436.40508759298, 7558.093028836574, 7740.0, 4015.437838702584, 4039.9596004040172, 4048.4736984192455, 4049.534303555129, 4060.7766572838186, 3695.224002959355, 3732.79469629173, 3733.141377483194, 3733.4959780429836, 3736.23407201523, 679.2528218959105, 680.8468094678658, 686.2794066230438, 702.9824254393681, 703.050881310227, 443.33942425785347, 544.9673019618835, 557.2338035201598, 572.516223790896, 596.0552524249027, 6938.653067346612, 7826.3452304341145, 8000.959995199987, 8157.388195885333, 8304.335653147733, 574.1018484490264, 582.1965687351428, 610.3896103896104, 615.6952308607268, 638.2054342343719, 3296.241864371208, 3561.8753343632848, 3753.230587729509, 3793.7534060286544, 3836.635519625631, 78147.70187639735, 78403.86384544669, 88945.81378608459, 89540.0, 97883.51058244663, 56786.432135678115, 77166.0, 77532.61233693908, 77709.44581108459, 78105.0, 69997.95003074958, 70843.64578176974, 70998.0, 71623.0, 71783.64108179425, 8123.4313598047565, 8147.837043258983, 8160.428769986044, 8305.792355190926, 8532.829343413221, 48504.27243591278, 50670.23994640157, 51583.742081289354, 51696.48303517067, 51946.740266298424, 51627.74186129045, 56508.43491565196, 69387.95918061132, 72919.0, 73376.26623733908, 11059.778804423706, 11277.32336059839, 11353.886461135284, 11392.031677307521, 11469.369184694922, 11896.583619573274, 11915.285082895054, 12189.0, 13020.218786872818, 13155.473781049033, 11395.715107122056, 11485.655430337103, 11528.962393384636, 11561.710957226136, 12218.20581662189, 11324.886751132382, 11333.376664283214, 11510.36692981894, 11614.477348519167, 11758.00056995165, 11168.497417616389, 11409.60066397672, 11411.828822567502, 11461.426928653367, 11607.739823768365, 9680.806383872143, 9708.563114659715, 9894.356866803635, 10055.39667619916, 10402.167826574007, 8796.868046979429, 8871.467711937305, 9074.546272686472, 9190.954045229731, 9711.757206069622], "unit": "score", "name": "yui.html", "value": 6852.3636921318985}], "name": "dromaeo_css", "value": 7443.824523488076}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 109.0, 111.0, 117.0, 166.0, 170.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 122.0}, {"lowerIsBetter": true, "replicates": [161.0, 148.0, 175.0, 157.0, 117.0, 141.0, 140.0, 117.0, 161.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [183.0, 184.0, 187.0, 186.0, 186.0, 184.0, 188.0, 182.0, 179.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.1}, {"lowerIsBetter": true, "replicates": [82.0, 72.0, 84.0, 77.0, 60.0, 57.0, 56.0, 77.0, 75.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.5}, {"lowerIsBetter": true, "replicates": [96.0, 92.0, 128.0, 79.0, 79.0, 85.0, 114.0, 77.0, 80.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 94.3}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 88.0, 85.0, 92.0, 129.0, 116.0, 85.0, 89.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.1}, {"lowerIsBetter": true, "replicates": [138.0, 120.0, 94.0, 94.0, 93.0, 93.0, 94.0, 95.0, 97.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 101.0}, {"lowerIsBetter": true, "replicates": [128.0, 135.0, 84.0, 86.0, 84.0, 94.0, 85.0, 87.0, 84.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 54.0, 52.0, 54.0, 53.0, 55.0, 66.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [63.0, 79.0, 74.0, 76.0, 71.0, 68.0, 66.0, 67.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 82.0, 81.0, 83.0, 82.0, 83.0, 79.0, 80.0, 71.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.5}, {"lowerIsBetter": true, "replicates": [119.0, 130.0, 133.0, 134.0, 125.0, 120.0, 117.0, 126.0, 130.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [158.0, 134.0, 140.0, 138.0, 135.0, 126.0, 139.0, 164.0, 141.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 69.0, 88.0, 87.0, 68.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1448.8999999999999}]} 05:28:33 INFO - Return code: 0 05:28:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:28:33 ERROR - # TBPL SUCCESS # 05:28:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:33 INFO - 2016-03-15 05:28:33.846 screenresolution[1675:9977] starting screenresolution argv=screenresolution get 05:28:33 INFO - 2016-03-15 05:28:33.848 screenresolution[1675:9977] Display 0: 1600x1200x32@60 05:28:33 INFO - 2016-03-15 05:28:33.854 screenresolution[1676:9980] starting screenresolution argv=screenresolution list 05:28:33 INFO - Available Modes on Display 0 05:28:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:34 INFO - Intel Iris: 05:28:34 INFO - Chipset Model: Intel Iris 05:28:34 INFO - Type: GPU 05:28:34 INFO - Bus: Built-In 05:28:34 INFO - VRAM (Dynamic, Max): 1536 MB 05:28:34 INFO - Vendor: Intel (0x8086) 05:28:34 INFO - Device ID: 0x0a2e 05:28:34 INFO - Revision ID: 0x0009 05:28:34 INFO - Displays: 05:28:34 INFO - Display: 05:28:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:34 INFO - Display Serial Number: 1600x1200 60 05:28:34 INFO - Main Display: Yes 05:28:34 INFO - Mirror: Off 05:28:34 INFO - Online: Yes 05:28:34 INFO - Rotation: Supported 05:28:34 INFO - Return code: 0 05:28:34 INFO - Running post-action listener: _resource_record_post_action 05:28:34 INFO - Running post-run listener: _resource_record_post_run 05:28:35 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39421440; Write bytes: 705058304; Read time: 424; Write time: 2075 05:28:35 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 386224640; Write bytes: 375780864; Read time: 29768; Write time: 678 05:28:35 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 33123840; Write bytes: 300191744; Read time: 340; Write time: 1338 05:28:35 INFO - Running post-run listener: _upload_blobber_files 05:28:35 INFO - Blob upload gear active. 05:28:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:35 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 05:28:35 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'] 05:28:35 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 05:28:35 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:28:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:28:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:36 INFO - (blobuploader) - INFO - Done attempting. 05:28:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:28:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:28:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:37 INFO - (blobuploader) - INFO - Done attempting. 05:28:37 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:37 INFO - Return code: 0 05:28:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7ad2c7504badd40fbf5b8197ed30f4bdcfd1daf3db2e3d30b64fb2b209514f4810bbccfda77be14777da4c5d2b8f58d1b752400f5ddbbdbf8e778a2e85a5210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/358f49ce686454af77eed3ceb670bf0799b6334bdcfafbaf98642330bb7d5b82e6924afade76dc69aff2fefce743b0fc3e32e87bdba485ac7582f7e20601ddb2"} 05:28:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:37 INFO - Contents: 05:28:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7ad2c7504badd40fbf5b8197ed30f4bdcfd1daf3db2e3d30b64fb2b209514f4810bbccfda77be14777da4c5d2b8f58d1b752400f5ddbbdbf8e778a2e85a5210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/358f49ce686454af77eed3ceb670bf0799b6334bdcfafbaf98642330bb7d5b82e6924afade76dc69aff2fefce743b0fc3e32e87bdba485ac7582f7e20601ddb2"} 05:28:37 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:37 INFO - Copying logs to upload dir... 05:28:37 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.718968 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-15 05:28:37.232860) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 05:28:37.236271) ========= 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.c7ksMjojXl/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.r2MPfN9lcm/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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/c7ad2c7504badd40fbf5b8197ed30f4bdcfd1daf3db2e3d30b64fb2b209514f4810bbccfda77be14777da4c5d2b8f58d1b752400f5ddbbdbf8e778a2e85a5210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/358f49ce686454af77eed3ceb670bf0799b6334bdcfafbaf98642330bb7d5b82e6924afade76dc69aff2fefce743b0fc3e32e87bdba485ac7582f7e20601ddb2"} build_url:https://queue.taskcluster.net/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011015 build_url: 'https://queue.taskcluster.net/v1/task/ExydkHAcQUOIWbAhN6Uumg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7ad2c7504badd40fbf5b8197ed30f4bdcfd1daf3db2e3d30b64fb2b209514f4810bbccfda77be14777da4c5d2b8f58d1b752400f5ddbbdbf8e778a2e85a5210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/358f49ce686454af77eed3ceb670bf0799b6334bdcfafbaf98642330bb7d5b82e6924afade76dc69aff2fefce743b0fc3e32e87bdba485ac7582f7e20601ddb2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 05:28:37.263835) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:28:37.264167) ========= 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.c7ksMjojXl/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.r2MPfN9lcm/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005269 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:28:37.312891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 05:28:37.313199) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 05:28:37.313586) ========= ========= Total master_lag: 0.98 =========