builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0083 starttime: 1456438564.46 results: success (0) buildid: 20160225131727 builduid: 2a6e69267f0a4342ac89968dea60f658 revision: c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:04.461326) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:04.461796) ========= ========= Started set props: basedir (results: 0, elapsed: 5 secs) (at 2016-02-25 14:16:04.462083) ========= 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.r7JnyNxF9i/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.GsASjBpe26/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005510 basedir: '/builds/slave/test' ========= master_lag: 5.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 5 secs) (at 2016-02-25 14:16:09.521371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:09.521729) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:09.941561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:09.942073) ========= 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.r7JnyNxF9i/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.GsASjBpe26/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005829 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:09.970549) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:09.970855) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:09.971184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:09.971449) ========= 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.r7JnyNxF9i/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.GsASjBpe26/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-25 14:16:10-- 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% 170M=0s 2016-02-25 14:16:10 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176040 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:10.163256) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:10.163560) ========= 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.r7JnyNxF9i/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.GsASjBpe26/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.026821 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:10.211876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 14:16:10.212243) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a --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 c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r7JnyNxF9i/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.GsASjBpe26/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-25 14:16:10,384 truncating revision to first 12 chars 2016-02-25 14:16:10,384 Setting DEBUG logging. 2016-02-25 14:16:10,384 attempt 1/10 2016-02-25 14:16:10,384 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c75bc39acae8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 14:16:11,409 unpacking tar archive at: fx-team-c75bc39acae8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.264278 ========= master_lag: 0.51 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 14:16:11.986444) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:11.986803) ========= echo c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r7JnyNxF9i/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.GsASjBpe26/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a program finished with exit code 0 elapsedTime=0.005982 script_repo_revision: 'c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a' ========= master_lag: 0.26 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:12.248506) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:12.248795) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 14:16:12.293242) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-25 14:16:12.293517) ========= /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.r7JnyNxF9i/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.GsASjBpe26/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 14:16:12 INFO - MultiFileLogger online at 20160225 14:16:12 in /builds/slave/test 14:16:12 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 14:16:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:16:12 INFO - {'append_to_log': False, 14:16:12 INFO - 'base_work_dir': '/builds/slave/test', 14:16:12 INFO - 'blob_upload_branch': 'Fx-Team', 14:16:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:16:12 INFO - 'branch': 'Fx-Team', 14:16:12 INFO - 'buildbot_json_path': 'buildprops.json', 14:16:12 INFO - 'config_files': ('talos/mac_config.py',), 14:16:12 INFO - 'default_actions': ('clobber', 14:16:12 INFO - 'read-buildbot-config', 14:16:12 INFO - 'download-and-extract', 14:16:12 INFO - 'populate-webroot', 14:16:12 INFO - 'create-virtualenv', 14:16:12 INFO - 'install', 14:16:12 INFO - 'run-tests'), 14:16:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:16:12 INFO - 'download_minidump_stackwalk': True, 14:16:12 INFO - 'download_symbols': 'ondemand', 14:16:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:16:12 INFO - 'tooltool.py': '/tools/tooltool.py', 14:16:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:16:12 INFO - '/tools/misc-python/virtualenv.py')}, 14:16:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:16:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:16:12 INFO - 'installer_path': 'installer.exe', 14:16:12 INFO - 'log_level': 'info', 14:16:12 INFO - 'log_name': 'talos', 14:16:12 INFO - 'log_to_console': True, 14:16:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:16:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:16:12 INFO - 'opt_config_files': (), 14:16:12 INFO - 'pip_index': False, 14:16:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:16:12 INFO - 'cmd': ('bash', 14:16:12 INFO - '-c', 14:16:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:16:12 INFO - 'enabled': True, 14:16:12 INFO - 'halt_on_failure': False, 14:16:12 INFO - 'name': 'check_screen_resolution'},), 14:16:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:16:12 INFO - 'cmd': ('bash', 14:16:12 INFO - '-c', 14:16:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:16:12 INFO - 'enabled': True, 14:16:12 INFO - 'halt_on_failure': False, 14:16:12 INFO - 'name': 'check_screen_resolution'},), 14:16:12 INFO - 'run_cmd_checks_enabled': True, 14:16:12 INFO - 'sps_profile': False, 14:16:12 INFO - 'sps_profile_interval': 0, 14:16:12 INFO - 'suite': 'dromaeojs', 14:16:12 INFO - 'system_bits': '32', 14:16:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:16:12 INFO - 'title': 't-yosemite-r7-0083', 14:16:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:16:12 INFO - 'use_talos_json': True, 14:16:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:16:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:16:12 INFO - 'work_dir': 'build'} 14:16:12 INFO - ##### 14:16:12 INFO - ##### Running clobber step. 14:16:12 INFO - ##### 14:16:12 INFO - Running pre-action listener: _resource_record_pre_action 14:16:12 INFO - Running main action method: clobber 14:16:12 INFO - rmtree: /builds/slave/test/build 14:16:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:16:14 INFO - Running post-action listener: _resource_record_post_action 14:16:14 INFO - ##### 14:16:14 INFO - ##### Running read-buildbot-config step. 14:16:14 INFO - ##### 14:16:14 INFO - Running pre-action listener: _resource_record_pre_action 14:16:14 INFO - Running main action method: read_buildbot_config 14:16:14 INFO - Using buildbot properties: 14:16:14 INFO - { 14:16:14 INFO - "project": "", 14:16:14 INFO - "product": "firefox", 14:16:14 INFO - "script_repo_revision": "production", 14:16:14 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:16:14 INFO - "repository": "", 14:16:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:16:14 INFO - "buildid": "20160225131727", 14:16:14 INFO - "pgo_build": "False", 14:16:14 INFO - "basedir": "/builds/slave/test", 14:16:14 INFO - "buildnumber": 448, 14:16:14 INFO - "slavename": "t-yosemite-r7-0083", 14:16:14 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:16:14 INFO - "platform": "yosemite_r7", 14:16:14 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:16:14 INFO - "branch": "fx-team", 14:16:14 INFO - "repo_path": "integration/fx-team", 14:16:14 INFO - "revision": "c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a", 14:16:14 INFO - "stage_platform": "macosx64", 14:16:14 INFO - "builduid": "2a6e69267f0a4342ac89968dea60f658", 14:16:14 INFO - "slavebuilddir": "test" 14:16:14 INFO - } 14:16:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 14:16:14 INFO - Running post-action listener: _resource_record_post_action 14:16:14 INFO - ##### 14:16:14 INFO - ##### Running download-and-extract step. 14:16:14 INFO - ##### 14:16:14 INFO - Running pre-action listener: _resource_record_pre_action 14:16:14 INFO - Running main action method: download_and_extract 14:16:14 INFO - mkdir: /builds/slave/test/build/tests 14:16:14 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')]} 14:16:14 INFO - https://queue.taskcluster.net/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:16:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/test_packages.json 14:16:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/test_packages.json 14:16:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:16:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:16:15 INFO - Downloaded 1277 bytes. 14:16:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:16:15 INFO - Using the following test package requirements: 14:16:15 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:16:15 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:16:15 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 14:16:15 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:16:15 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 14:16:15 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:16:15 INFO - u'jsshell-mac.zip'], 14:16:15 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:16:15 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 14:16:15 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:16:15 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:16:15 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 14:16:15 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:16:15 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 14:16:15 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:16:15 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 14:16:15 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:16:15 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:16:15 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 14:16:15 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:16:15 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')]} 14:16:15 INFO - https://queue.taskcluster.net/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:16:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:16:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:16:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:16:16 INFO - Downloaded 17829664 bytes. 14:16:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:16:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:16:19 INFO - Return code: 0 14:16:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:19 INFO - https://queue.taskcluster.net/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:16:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:16:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:16:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:16:20 INFO - Downloaded 17829664 bytes. 14:16:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:16:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:16:24 INFO - Return code: 0 14:16:24 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')]} 14:16:24 INFO - https://queue.taskcluster.net/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:16:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:16:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:16:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:16:25 INFO - Downloaded 10713410 bytes. 14:16:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:16:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:16:25 INFO - Return code: 0 14:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:25 INFO - https://queue.taskcluster.net/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:16:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:16:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:16:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 14:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 14:16:28 INFO - Downloaded 111440490 bytes. 14:16:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:16:28 INFO - mkdir: /builds/slave/test/properties 14:16:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:16:28 INFO - Writing to file /builds/slave/test/properties/build_url 14:16:28 INFO - Contents: 14:16:28 INFO - build_url:https://queue.taskcluster.net/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:16:29 INFO - Running post-action listener: _resource_record_post_action 14:16:29 INFO - Running post-action listener: set_extra_try_arguments 14:16:29 INFO - ##### 14:16:29 INFO - ##### Running populate-webroot step. 14:16:29 INFO - ##### 14:16:29 INFO - Running pre-action listener: _resource_record_pre_action 14:16:29 INFO - Running main action method: populate_webroot 14:16:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:16:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:16:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:16:29 INFO - '--tppagecycles', 14:16:29 INFO - '7'], 14:16:29 INFO - 'tests': ['tsvgm']}}, 14:16:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:16:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:16:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:16:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:16:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:16:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:16:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:29 INFO - 'talos_options': ['--e10s'], 14:16:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:29 INFO - 'tests': ['damp', 'tps']}, 14:16:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:29 INFO - 'talos_options': ['--e10s'], 14:16:29 INFO - 'tests': ['damp', 'tps']}, 14:16:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:16:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:16:29 INFO - 'other': {'tests': ['a11yr', 14:16:29 INFO - 'ts_paint', 14:16:29 INFO - 'tpaint', 14:16:29 INFO - 'sessionrestore', 14:16:29 INFO - 'sessionrestore_no_auto_restore']}, 14:16:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:16:29 INFO - 'tests': ['a11yr', 14:16:29 INFO - 'ts_paint', 14:16:29 INFO - 'tpaint', 14:16:29 INFO - 'sessionrestore', 14:16:29 INFO - 'sessionrestore_no_auto_restore']}, 14:16:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:16:29 INFO - 'tests': ['a11yr', 14:16:29 INFO - 'ts_paint', 14:16:29 INFO - 'tpaint', 14:16:29 INFO - 'sessionrestore', 14:16:29 INFO - 'sessionrestore_no_auto_restore']}, 14:16:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:16:29 INFO - 'tests': ['a11yr', 14:16:29 INFO - 'ts_paint', 14:16:29 INFO - 'tpaint', 14:16:29 INFO - 'sessionrestore', 14:16:29 INFO - 'sessionrestore_no_auto_restore']}, 14:16:29 INFO - 'other_l64': {'tests': ['a11yr', 14:16:29 INFO - 'ts_paint', 14:16:29 INFO - 'tpaint', 14:16:29 INFO - 'sessionrestore', 14:16:29 INFO - 'sessionrestore_no_auto_restore']}, 14:16:29 INFO - 'other_nol64': {'tests': ['a11yr', 14:16:29 INFO - 'ts_paint', 14:16:29 INFO - 'tpaint', 14:16:29 INFO - 'sessionrestore', 14:16:29 INFO - 'sessionrestore_no_auto_restore']}, 14:16:29 INFO - 'svgr': {'tests': ['tsvgx', 14:16:29 INFO - 'tsvgr_opacity', 14:16:29 INFO - 'tart', 14:16:29 INFO - 'tscrollx', 14:16:29 INFO - 'cart']}, 14:16:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:16:29 INFO - 'tests': ['tsvgx', 14:16:29 INFO - 'tsvgr_opacity', 14:16:29 INFO - 'tart', 14:16:29 INFO - 'tscrollx', 14:16:29 INFO - 'cart']}, 14:16:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:29 INFO - 'tests': ['tp5o']}, 14:16:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:29 INFO - 'talos_options': ['--e10s'], 14:16:29 INFO - 'tests': ['tp5o']}, 14:16:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:29 INFO - 'talos_options': ['--xperf_path', 14:16:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:29 INFO - 'tests': ['tp5n']}, 14:16:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:29 INFO - 'talos_options': ['--e10s', 14:16:29 INFO - '--xperf_path', 14:16:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:29 INFO - 'tests': ['tp5n']}}, 14:16:29 INFO - 'talos.zip': {'path': '', 14:16:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:16:29 INFO - Running post-action listener: _resource_record_post_action 14:16:29 INFO - ##### 14:16:29 INFO - ##### Running create-virtualenv step. 14:16:29 INFO - ##### 14:16:29 INFO - Running pre-action listener: _resource_record_pre_action 14:16:29 INFO - Running main action method: create_virtualenv 14:16:29 INFO - Creating virtualenv /builds/slave/test/build/venv 14:16:29 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 14:16:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:16:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:16:29 INFO - Using real prefix '/tools/python27' 14:16:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:16:30 INFO - Installing distribute.............................................................................................................................................................................................done. 14:16:33 INFO - Installing pip.................done. 14:16:33 INFO - Return code: 0 14:16:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:16: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')]} 14:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16: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')]} 14:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:33 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 0x1061bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22bda3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106063d30>, '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 0x105e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10605ab20>, '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.r7JnyNxF9i/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.GsASjBpe26/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 14:16:33 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 14:16:33 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 14:16:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7JnyNxF9i/Render', 14:16:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:33 INFO - 'HOME': '/Users/cltbld', 14:16:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:33 INFO - 'LOGNAME': 'cltbld', 14:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:33 INFO - 'MOZ_NO_REMOTE': '1', 14:16:33 INFO - 'NO_EM_RESTART': '1', 14:16:33 INFO - 'PAGER': '/bin/cat', 14:16:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:33 INFO - 'PWD': '/builds/slave/test', 14:16:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:33 INFO - 'SHELL': '/bin/bash', 14:16:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsASjBpe26/Listeners', 14:16:33 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 14:16:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:33 INFO - 'USER': 'cltbld', 14:16:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:33 INFO - 'XPC_FLAGS': '0x0', 14:16:33 INFO - 'XPC_SERVICE_NAME': '0', 14:16:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:33 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 14:16:33 INFO - Cleaning up... 14:16:33 INFO - Return code: 0 14:16:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:16: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')]} 14:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16: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')]} 14:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:33 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 0x1061bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22bda3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106063d30>, '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 0x105e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10605ab20>, '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.r7JnyNxF9i/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.GsASjBpe26/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 14:16:33 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 14:16:33 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 14:16:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7JnyNxF9i/Render', 14:16:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:33 INFO - 'HOME': '/Users/cltbld', 14:16:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:33 INFO - 'LOGNAME': 'cltbld', 14:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:33 INFO - 'MOZ_NO_REMOTE': '1', 14:16:33 INFO - 'NO_EM_RESTART': '1', 14:16:33 INFO - 'PAGER': '/bin/cat', 14:16:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:33 INFO - 'PWD': '/builds/slave/test', 14:16:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:33 INFO - 'SHELL': '/bin/bash', 14:16:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsASjBpe26/Listeners', 14:16:33 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 14:16:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:33 INFO - 'USER': 'cltbld', 14:16:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:33 INFO - 'XPC_FLAGS': '0x0', 14:16:33 INFO - 'XPC_SERVICE_NAME': '0', 14:16:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:34 INFO - Downloading/unpacking psutil>=0.7.1 14:16:34 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 14:16:34 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 14:16:34 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 14:16:34 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 14:16:34 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 14:16:34 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 14:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:16:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:16:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:16:36 INFO - Installing collected packages: psutil 14:16:36 INFO - Running setup.py install for psutil 14:16:37 INFO - building 'psutil._psutil_osx' extension 14:16:37 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 14:16:37 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 14:16:37 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 14:16:37 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 14:16:37 INFO - building 'psutil._psutil_posix' extension 14:16:37 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 14:16:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:16:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:16:37 INFO - ^ 14:16:38 INFO - 1 warning generated. 14:16:38 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 14:16:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:16:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:16:38 INFO - Successfully installed psutil 14:16:38 INFO - Cleaning up... 14:16:38 INFO - Return code: 0 14:16:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:16: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')]} 14:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16: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')]} 14:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:38 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 0x1061bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22bda3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106063d30>, '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 0x105e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10605ab20>, '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.r7JnyNxF9i/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.GsASjBpe26/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 14:16:38 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 14:16:38 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 14:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7JnyNxF9i/Render', 14:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:38 INFO - 'HOME': '/Users/cltbld', 14:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:38 INFO - 'LOGNAME': 'cltbld', 14:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:38 INFO - 'MOZ_NO_REMOTE': '1', 14:16:38 INFO - 'NO_EM_RESTART': '1', 14:16:38 INFO - 'PAGER': '/bin/cat', 14:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:38 INFO - 'PWD': '/builds/slave/test', 14:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:38 INFO - 'SHELL': '/bin/bash', 14:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsASjBpe26/Listeners', 14:16:38 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 14:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:38 INFO - 'USER': 'cltbld', 14:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:38 INFO - 'XPC_FLAGS': '0x0', 14:16:38 INFO - 'XPC_SERVICE_NAME': '0', 14:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:16:38 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 14:16:38 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 14:16:38 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 14:16:38 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 14:16:38 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 14:16:38 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 14:16:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:16:40 INFO - Installing collected packages: mozsystemmonitor 14:16:40 INFO - Running setup.py install for mozsystemmonitor 14:16:40 INFO - Successfully installed mozsystemmonitor 14:16:40 INFO - Cleaning up... 14:16:41 INFO - Return code: 0 14:16:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:41 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 0x1061bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22bda3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106063d30>, '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 0x105e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10605ab20>, '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.r7JnyNxF9i/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.GsASjBpe26/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 14:16:41 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 14:16:41 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 14:16:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7JnyNxF9i/Render', 14:16:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:41 INFO - 'HOME': '/Users/cltbld', 14:16:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:41 INFO - 'LOGNAME': 'cltbld', 14:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:41 INFO - 'MOZ_NO_REMOTE': '1', 14:16:41 INFO - 'NO_EM_RESTART': '1', 14:16:41 INFO - 'PAGER': '/bin/cat', 14:16:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:41 INFO - 'PWD': '/builds/slave/test', 14:16:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:41 INFO - 'SHELL': '/bin/bash', 14:16:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsASjBpe26/Listeners', 14:16:41 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 14:16:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:41 INFO - 'USER': 'cltbld', 14:16:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:41 INFO - 'XPC_FLAGS': '0x0', 14:16:41 INFO - 'XPC_SERVICE_NAME': '0', 14:16:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:16:41 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 14:16:41 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 14:16:41 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 14:16:41 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 14:16:41 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 14:16:41 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 14:16:43 INFO - Downloading blobuploader-1.2.4.tar.gz 14:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:16:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:16:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:16:44 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 14:16:44 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 14:16:44 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 14:16:44 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 14:16:44 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 14:16:44 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 14:16:44 INFO - Downloading docopt-0.6.1.tar.gz 14:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:16:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:16:44 INFO - Running setup.py install for blobuploader 14:16:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:16:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:16:45 INFO - Running setup.py install for requests 14:16:45 INFO - Running setup.py install for docopt 14:16:45 INFO - Successfully installed blobuploader requests docopt 14:16:45 INFO - Cleaning up... 14:16:45 INFO - Return code: 0 14:16:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16: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')]} 14:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16: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')]} 14:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:45 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 0x1061bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22bda3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106063d30>, '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 0x105e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10605ab20>, '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.r7JnyNxF9i/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.GsASjBpe26/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 14:16:45 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 14:16:45 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 14:16:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7JnyNxF9i/Render', 14:16:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:45 INFO - 'HOME': '/Users/cltbld', 14:16:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:45 INFO - 'LOGNAME': 'cltbld', 14:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:45 INFO - 'MOZ_NO_REMOTE': '1', 14:16:45 INFO - 'NO_EM_RESTART': '1', 14:16:45 INFO - 'PAGER': '/bin/cat', 14:16:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:45 INFO - 'PWD': '/builds/slave/test', 14:16:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:45 INFO - 'SHELL': '/bin/bash', 14:16:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsASjBpe26/Listeners', 14:16:45 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 14:16:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:45 INFO - 'USER': 'cltbld', 14:16:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:45 INFO - 'XPC_FLAGS': '0x0', 14:16:45 INFO - 'XPC_SERVICE_NAME': '0', 14:16:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:16:46 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Vw199M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:16:46 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-vWIkGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:16:46 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-gNFQHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:16:46 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-pZRkpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:16:46 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-C6Bgxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:16:46 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-kKPIww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:16:46 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-BcVfDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:16:46 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-qNGl4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:16:46 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-AVrBPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:16:46 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-E4tDRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:16:47 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-mC_uzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:16:47 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-HkM6vW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:16:47 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Wz2Amq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:16:47 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-PMZb0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:47 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-CivZkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:16:47 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-LNxAKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:16:47 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-AuXwaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:16:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:16:47 INFO - Running setup.py install for manifestparser 14:16:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:16:47 INFO - Running setup.py install for mozcrash 14:16:48 INFO - Running setup.py install for mozdebug 14:16:48 INFO - Running setup.py install for mozdevice 14:16:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:16:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:16:48 INFO - Running setup.py install for mozfile 14:16:48 INFO - Running setup.py install for mozhttpd 14:16:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:16:48 INFO - Running setup.py install for mozinfo 14:16:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:16:48 INFO - Running setup.py install for mozInstall 14:16:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:16:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:16:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:16:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:16:48 INFO - Running setup.py install for mozleak 14:16:49 INFO - Running setup.py install for mozlog 14:16:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:16:49 INFO - Running setup.py install for moznetwork 14:16:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:16:49 INFO - Running setup.py install for mozprocess 14:16:49 INFO - Running setup.py install for mozprofile 14:16:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:16:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:16:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:16:49 INFO - Running setup.py install for mozrunner 14:16:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:16:49 INFO - Running setup.py install for mozscreenshot 14:16:49 INFO - Running setup.py install for moztest 14:16:50 INFO - Running setup.py install for mozversion 14:16:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:16:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:16:50 INFO - Cleaning up... 14:16:50 INFO - Return code: 0 14:16:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:50 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 0x1061bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22bda3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106063d30>, '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 0x105e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10605ab20>, '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.r7JnyNxF9i/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.GsASjBpe26/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 14:16:50 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 14:16:50 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 14:16:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7JnyNxF9i/Render', 14:16:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:50 INFO - 'HOME': '/Users/cltbld', 14:16:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:50 INFO - 'LOGNAME': 'cltbld', 14:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:50 INFO - 'MOZ_NO_REMOTE': '1', 14:16:50 INFO - 'NO_EM_RESTART': '1', 14:16:50 INFO - 'PAGER': '/bin/cat', 14:16:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:50 INFO - 'PWD': '/builds/slave/test', 14:16:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:50 INFO - 'SHELL': '/bin/bash', 14:16:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsASjBpe26/Listeners', 14:16:50 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 14:16:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:50 INFO - 'USER': 'cltbld', 14:16:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:50 INFO - 'XPC_FLAGS': '0x0', 14:16:50 INFO - 'XPC_SERVICE_NAME': '0', 14:16:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:16:50 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-0AWk7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:16:50 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)) 14:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:16:50 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Ox_gxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:16:50 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-inAuL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:16:50 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)) 14:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:16:50 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-vx8Hgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:16:51 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)) 14:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:16:51 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-J3qT8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:16:51 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)) 14:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:16:51 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-CBIPe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:16:51 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)) 14:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:16:51 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-iIw57z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:16:51 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)) 14:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:16:51 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-L54qQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:16:51 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)) 14:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:16:51 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-WFTW2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:16:51 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)) 14:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:16:51 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-LQDXiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:16:51 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)) 14:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:16:51 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-k7i5sW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:16:51 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)) 14:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:16:51 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-umGzac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:16:51 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)) 14:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:16:51 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-FAqhJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:16:51 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)) 14:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:16:51 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ABbLrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:16:52 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)) 14:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:52 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-BWEdgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:52 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)) 14:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:16:52 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-jufukr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:16:52 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)) 14:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:16:52 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-v42lJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:16:52 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)) 14:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:16:52 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)) 14:16:52 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)) 14:16:52 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)) 14:16:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:16:52 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 14:16:52 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 14:16:52 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 14:16:52 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 14:16:52 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 14:16:52 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 14:16:54 INFO - Downloading blessings-1.6.tar.gz 14:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:16:54 INFO - Installing collected packages: blessings 14:16:54 INFO - Running setup.py install for blessings 14:16:54 INFO - Successfully installed blessings 14:16:54 INFO - Cleaning up... 14:16:55 INFO - Return code: 0 14:16:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:16:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:55 INFO - Reading from file tmpfile_stdout 14:16:55 INFO - Current package versions: 14:16:55 INFO - blessings == 1.6 14:16:55 INFO - blobuploader == 1.2.4 14:16:55 INFO - docopt == 0.6.1 14:16:55 INFO - manifestparser == 1.1 14:16:55 INFO - mozInstall == 1.12 14:16:55 INFO - mozcrash == 0.16 14:16:55 INFO - mozdebug == 0.1 14:16:55 INFO - mozdevice == 0.48 14:16:55 INFO - mozfile == 1.2 14:16:55 INFO - mozhttpd == 0.7 14:16:55 INFO - mozinfo == 0.9 14:16:55 INFO - mozleak == 0.1 14:16:55 INFO - mozlog == 3.1 14:16:55 INFO - moznetwork == 0.27 14:16:55 INFO - mozprocess == 0.22 14:16:55 INFO - mozprofile == 0.28 14:16:55 INFO - mozrunner == 6.11 14:16:55 INFO - mozscreenshot == 0.1 14:16:55 INFO - mozsystemmonitor == 0.0 14:16:55 INFO - moztest == 0.7 14:16:55 INFO - mozversion == 1.4 14:16:55 INFO - psutil == 3.1.1 14:16:55 INFO - requests == 1.2.3 14:16:55 INFO - wsgiref == 0.1.2 14:16:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16: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')]} 14:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16: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')]} 14:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:55 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 0x1061bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22bda3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106063d30>, '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 0x105e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10605ab20>, '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.r7JnyNxF9i/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.GsASjBpe26/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 14:16:55 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 14:16:55 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 14:16:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7JnyNxF9i/Render', 14:16:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:55 INFO - 'HOME': '/Users/cltbld', 14:16:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:55 INFO - 'LOGNAME': 'cltbld', 14:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:55 INFO - 'MOZ_NO_REMOTE': '1', 14:16:55 INFO - 'NO_EM_RESTART': '1', 14:16:55 INFO - 'PAGER': '/bin/cat', 14:16:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:55 INFO - 'PWD': '/builds/slave/test', 14:16:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:55 INFO - 'SHELL': '/bin/bash', 14:16:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsASjBpe26/Listeners', 14:16:55 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 14:16:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:55 INFO - 'USER': 'cltbld', 14:16:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:55 INFO - 'XPC_FLAGS': '0x0', 14:16:55 INFO - 'XPC_SERVICE_NAME': '0', 14:16:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:55 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)) 14:16:55 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)) 14:16:55 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)) 14:16:55 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)) 14:16:55 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)) 14:16:55 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)) 14:16:55 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)) 14:16:55 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)) 14:16:55 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)) 14:16:55 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)) 14:16:55 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)) 14:16:55 INFO - Cleaning up... 14:16:55 INFO - Return code: 0 14:16:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:16: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')]} 14:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16: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')]} 14:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22bda3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106063d30>, '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 0x105e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10605ab20>, '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.r7JnyNxF9i/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.GsASjBpe26/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 14:16: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', 'jsonschema'] in /builds/slave/test/build 14:16: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 jsonschema 14:16:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7JnyNxF9i/Render', 14:16:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:55 INFO - 'HOME': '/Users/cltbld', 14:16:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:55 INFO - 'LOGNAME': 'cltbld', 14:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:55 INFO - 'MOZ_NO_REMOTE': '1', 14:16:55 INFO - 'NO_EM_RESTART': '1', 14:16:55 INFO - 'PAGER': '/bin/cat', 14:16:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:55 INFO - 'PWD': '/builds/slave/test', 14:16:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:55 INFO - 'SHELL': '/bin/bash', 14:16:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsASjBpe26/Listeners', 14:16:55 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 14:16:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:55 INFO - 'USER': 'cltbld', 14:16:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:55 INFO - 'XPC_FLAGS': '0x0', 14:16:55 INFO - 'XPC_SERVICE_NAME': '0', 14:16:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:56 INFO - Downloading/unpacking jsonschema 14:16:56 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 14:16:56 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 14:16:56 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 14:16:56 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 14:16:56 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 14:16:56 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 14:16:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:16:58 INFO - Downloading/unpacking functools32 (from jsonschema) 14:16:58 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 14:16:58 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 14:16:58 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 14:16:58 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 14:16:58 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 14:16:58 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 14:16:59 INFO - Downloading functools32-3.2.3-2.tar.gz 14:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:16:59 INFO - warning: no files found matching '*.txt' 14:16:59 INFO - no previously-included directories found matching 'build' 14:16:59 INFO - no previously-included directories found matching 'dist' 14:16:59 INFO - no previously-included directories found matching '.git*' 14:16:59 INFO - Installing collected packages: jsonschema, functools32 14:16:59 INFO - Running setup.py install for functools32 14:16:59 INFO - warning: no files found matching '*.txt' 14:16:59 INFO - no previously-included directories found matching 'build' 14:16:59 INFO - no previously-included directories found matching 'dist' 14:16:59 INFO - no previously-included directories found matching '.git*' 14:16:59 INFO - Successfully installed jsonschema functools32 14:16:59 INFO - Cleaning up... 14:16:59 INFO - Return code: 0 14:16:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22bda3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106063d30>, '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 0x105e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10605ab20>, '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.r7JnyNxF9i/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.GsASjBpe26/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 14:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7JnyNxF9i/Render', 14:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:59 INFO - 'HOME': '/Users/cltbld', 14:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:59 INFO - 'LOGNAME': 'cltbld', 14:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:59 INFO - 'MOZ_NO_REMOTE': '1', 14:16:59 INFO - 'NO_EM_RESTART': '1', 14:16:59 INFO - 'PAGER': '/bin/cat', 14:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:59 INFO - 'PWD': '/builds/slave/test', 14:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:59 INFO - 'SHELL': '/bin/bash', 14:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsASjBpe26/Listeners', 14:16:59 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 14:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:59 INFO - 'USER': 'cltbld', 14:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:59 INFO - 'XPC_FLAGS': '0x0', 14:16:59 INFO - 'XPC_SERVICE_NAME': '0', 14:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:59 INFO - Downloading/unpacking flake8 14:16:59 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 14:16:59 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 14:16:59 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 14:16:59 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 14:16:59 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 14:16:59 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 14:17:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:17:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:17:02 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 14:17:02 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 14:17:02 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 14:17:02 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 14:17:02 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 14:17:02 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 14:17:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:17:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:17:02 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 14:17:02 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 14:17:02 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 14:17:02 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 14:17:02 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 14:17:02 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 14:17:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:17:02 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 14:17:02 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 14:17:02 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 14:17:02 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 14:17:02 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 14:17:02 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 14:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:17:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:03 INFO - no previously-included directories found matching 'docs/_build' 14:17:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:17:03 INFO - Running setup.py install for pep8 14:17:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:03 INFO - no previously-included directories found matching 'docs/_build' 14:17:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:17:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:17:03 INFO - Cleaning up... 14:17:03 INFO - Return code: 0 14:17:03 INFO - Running post-action listener: _resource_record_post_action 14:17:03 INFO - Running post-action listener: _start_resource_monitoring 14:17:03 INFO - Starting resource monitoring. 14:17:03 INFO - ##### 14:17:03 INFO - ##### Running install step. 14:17:03 INFO - ##### 14:17:03 INFO - Running pre-action listener: _resource_record_pre_action 14:17:03 INFO - Running main action method: install 14:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:17:04 INFO - Reading from file tmpfile_stdout 14:17:04 INFO - Detecting whether we're running mozinstall >=1.0... 14:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:17:04 INFO - Reading from file tmpfile_stdout 14:17:04 INFO - Output received: 14:17:04 INFO - Usage: mozinstall [options] installer 14:17:04 INFO - Options: 14:17:04 INFO - -h, --help show this help message and exit 14:17:04 INFO - -d DEST, --destination=DEST 14:17:04 INFO - Directory to install application into. [default: 14:17:04 INFO - "/builds/slave/test"] 14:17:04 INFO - --app=APP Application being installed. [default: firefox] 14:17:04 INFO - mkdir: /builds/slave/test/build/application 14:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:17:38 INFO - Reading from file tmpfile_stdout 14:17:38 INFO - Output received: 14:17:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:17:38 INFO - Running post-action listener: _resource_record_post_action 14:17:38 INFO - ##### 14:17:38 INFO - ##### Running run-tests step. 14:17:38 INFO - ##### 14:17:38 INFO - Running pre-action listener: _resource_record_pre_action 14:17:38 INFO - Running main action method: run_tests 14:17:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:17:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:17:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:17:38 INFO - 2016-02-25 14:17:38.102 screenresolution[1648:7629] starting screenresolution argv=screenresolution get 14:17:38 INFO - 2016-02-25 14:17:38.105 screenresolution[1648:7629] Display 0: 1600x1200x32@60 14:17:38 INFO - 2016-02-25 14:17:38.110 screenresolution[1649:7631] starting screenresolution argv=screenresolution list 14:17:38 INFO - Available Modes on Display 0 14:17:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:17:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:17:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:17:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:17:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:17:38 INFO - Intel Iris: 14:17:38 INFO - Chipset Model: Intel Iris 14:17:38 INFO - Type: GPU 14:17:38 INFO - Bus: Built-In 14:17:38 INFO - VRAM (Dynamic, Max): 1536 MB 14:17:38 INFO - Vendor: Intel (0x8086) 14:17:38 INFO - Device ID: 0x0a2e 14:17:38 INFO - Revision ID: 0x0009 14:17:38 INFO - Displays: 14:17:38 INFO - Display: 14:17:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:17:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:17:38 INFO - Display Serial Number: 1600x1200 60 14:17:38 INFO - Main Display: Yes 14:17:38 INFO - Mirror: Off 14:17:38 INFO - Online: Yes 14:17:38 INFO - Rotation: Supported 14:17:38 INFO - Return code: 0 14:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:17:38 INFO - Python 2.7.3 14:17:38 INFO - Return code: 0 14:17:38 INFO - grabbing minidump binary from tooltool 14:17: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')]} 14:17:38 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 0x106063d30>, '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 0x105e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10605ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:17:38 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 14:17:38 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 14:17:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:17:38 INFO - Return code: 0 14:17:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:17:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:17:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:17:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:17:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:17:39 INFO - Return code: 0 14:17:39 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/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 14:17:39 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/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0083 --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 14:17:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7JnyNxF9i/Render', 14:17:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:17:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:17:39 INFO - 'HOME': '/Users/cltbld', 14:17:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:17:39 INFO - 'LOGNAME': 'cltbld', 14:17:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:17:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:39 INFO - 'MOZ_NO_REMOTE': '1', 14:17:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:17:39 INFO - 'NO_EM_RESTART': '1', 14:17:39 INFO - 'PAGER': '/bin/cat', 14:17:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:39 INFO - 'PWD': '/builds/slave/test', 14:17:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:17:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:17:39 INFO - 'SHELL': '/bin/bash', 14:17:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsASjBpe26/Listeners', 14:17:39 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 14:17:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:17:39 INFO - 'USER': 'cltbld', 14:17:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:17:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:39 INFO - 'XPC_FLAGS': '0x0', 14:17:39 INFO - 'XPC_SERVICE_NAME': '0', 14:17:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:17:39 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/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 14:17:39 INFO - mozversion application_buildid: 20160225131727 14:17:39 INFO - mozversion application_changeset: c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a 14:17:39 INFO - mozversion application_display_name: Nightly 14:17:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:17:39 INFO - mozversion application_name: Firefox 14:17:39 INFO - mozversion application_remotingname: firefox 14:17:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:17:39 INFO - mozversion application_vendor: Mozilla 14:17:39 INFO - mozversion application_version: 47.0a1 14:17:39 INFO - mozversion platform_buildid: 20160225131727 14:17:39 INFO - mozversion platform_changeset: c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a 14:17:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:17:39 INFO - mozversion platform_version: 47.0a1 14:17:39 INFO - using testdate: 1456438659 14:17:39 INFO - actual date: 1456438659 14:17:39 INFO - starting webserver on 'localhost:49280' 14:17:39 INFO - SUITE-START | Running 2 tests 14:17:39 INFO - TEST-START | dromaeo_css 14:17:39 INFO - operating with platform_type : mac_ 14:17:39 INFO - Initialising browser for dromaeo_css test... 14:17:39 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpG455Cg/profile http://localhost:49280/getInfo.html) 14:17:42 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 14:17:42 INFO - PROCESS | 1667 | colorDepth:24 14:17:42 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 14:17:42 INFO - PROCESS | 1667 | __metrics 14:17:42 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:17:42 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:17:43 INFO - TEST-INFO | 1667: exit 0 14:17:43 INFO - Browser initialized. 14:17:43 INFO - Running cycle 1/1 for dromaeo_css test... 14:17:43 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpG455Cg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:17:54 INFO - PROCESS | 1670 | RSS: Main: 243568640 14:17:54 INFO - PROCESS | 1670 | 14:18:46 INFO - PROCESS | 1670 | 1456438726103 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] 14:20:55 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 14:20:57 INFO - PROCESS | 1670 | RSS: Main: 384086016 14:20:57 INFO - PROCESS | 1670 | 14:23:59 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 14:24:00 INFO - PROCESS | 1670 | RSS: Main: 379281408 14:24:00 INFO - PROCESS | 1670 | 14:27:02 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 14:27:03 INFO - PROCESS | 1670 | RSS: Main: 378322944 14:27:03 INFO - PROCESS | 1670 | 14:30:05 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 14:30:05 INFO - PROCESS | 1670 | RSS: Main: 335421440 14:30:05 INFO - PROCESS | 1670 | 14:33:08 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 14:33:09 INFO - PROCESS | 1670 | RSS: Main: 339193856 14:33:09 INFO - PROCESS | 1670 | 14:36:12 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 14:36:12 INFO - PROCESS | 1670 | RSS: Main: 413061120 14:36:12 INFO - PROCESS | 1670 | 14:36:12 INFO - PROCESS | 1670 | __start_tp_report 14:36:12 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 14:36:12 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 14:36:12 INFO - PROCESS | 1670 | |i|pagename|runs| 14:36:12 INFO - PROCESS | 1670 | |0;dojo.html;3195.9360812783743;3416.19719365949;3475.461303497959;3518.225990282138;3518.912027199318;5600.775968961247;5659.717014149297;5670.14947757836;5687.544996400288;5695.686737229451;5180.119379705449;5607.130894711316;5680.034394153004;5683.175939488771;5708.20085188074;4655.976720116403;5161.535461808437;5190.506901844319;5199.194124910645;5281.735913204344;5295.947040529584;5297.390800057985;5297.549708274802;5306.151015837467;5332.786688532454;5201.531862132408;5216.895662086756;5234.6335756497065;5255.500727430907;5316.946830531703;5261.421243663194;5287.206918962167;5300.708461034642;5318.601104917147;5354.839354819323;5109.540141387293;5131.61512886535;5146.125158723026;5206.557442617382;5228.451012643655;5538.335399752015;5572.4148964358565;5582.330120385539;5588.21764952907;5598.384177740486;6226.688665566749;6238.625682459067;6246.344133865924;6263.029230469285;6264.404881536247;6109.5723299369065;6143.542582966805;6260.342664020303;6270.78052268173;6321.620702757803;5801.419858014249;5803.100519419497;5825.883482330372;5840.649561026267;5861.736221870026;6266.893483640915;6306.180196574416;6314.684265786692;6315.5579109462815;6327.905081423783;6023.69881505923;6115.847103822351;6126.081087836771;6162.506999440034;6198.256209254918;6186.133941248228;6205.22434695663;6220.937790622126;6234.376562343729;6251.531135164881;6147.200863887755;6181.81454556364;6202.937970620236;6213.440790328892;6225.066240064027;6091.543134264948;6123.081537769282;6142.621558143003;6159.168512250789;6171.876562468726;4885.853424397274;4887.511248875084;4890.58430033444;4907.901841963141;4933.087378834927;4299.570042995738;4436.134953684001;4437.689361744711;4455.309427038814;4481.955180448153;5574.080276754371;5638.520725738276;5662.943370566241;5702.030654788696;5725;6283.2460104787715;6285.025820997753;6287.088372186007;6290.087937249074;6307.990721484541;5581.916271255935;5654.6889921054735;5666.716664166775;5669.659820410706;5678.971605141948;5306.09796334624;5308.9734551327765;5327.7336133193185;5327.9733601331745;5346.652467589672;6273.843153921189;6328.936710632835;6333.46165575922;6338.176037115146;6352.872942541123;6261.029540421242;6299.559030867978;6327.746890124344;6330.49356051524;6331.841703957438;6153.846153846011;6214.40963108504;6299.811005669837;6326.335734747785;6330.335314791881;6149.41580549847;6166.907496387468;6203.751849925952;6207.596506227081;6216.844578885564;5228.215767634885;5790.768369265183;6237.4698150657705;6272.341404152498;6274.529410294337;5879.412058794086;6026.758929642765;6038.215032045806;6045.758169673164;6050.9394906050375;4654.604358629555;4998.225275082368;5948.583599148018;6132.41742034506;6138.693065346804;5965.194698715618;5973.49225315853;5978.641281523122;5979.162917191509;5980.491658209101;5951.553633477593;6019.458248757633;6102.567671004098;6121.816345509642;6146.231721034871;5947.732352044082;6011.909821352596;6015.729292181775;6019.668918209541;6048.546359023179 14:36:12 INFO - PROCESS | 1670 | |1;ext.html;480.169307098719;502.63056653359774;504.45266885429305;526.9604779641528;604.4801470735168;28693;29108.708912910864;29129.563056554114;29159.271018224554;29177.854110729415;29871;37695.4345684815;38259.42610860839;38261;38403.423948640724;9330.53347332634;9483.573239204217;9512.619495220182;9518.286128540352;9523.095305945924;9294.256459483258;9432.81134377312;9435.15083642472;9443.716688499357;9448.57481413338;9395.06049395062;9471.47906865122;9478.905210947905;9486.762830929247;9606.80786384272;9473.668421605245;9561.952190239073;9565.234781217487;9575.473348965805;9581.999999999965;8059.5164290142775;9335.159835614759;9464.858027129598;9474.573644185959;9474.573644186028;38327.80836095801;38759.22481550381;38787.41818872719;38790.61209387898;38838.61161388378;3147.6537580866316;3268.3790079884748;3332.6167490738635;3345.7657963942534;3554.2358392945384;27396.863015684794;28312.009079682113;28978.565321520193;29048.41903161946;29083;2684.9731502685113;2754.077384076337;2756.2558109310376;2776.1671498550354;2800.271929298397;488814;492428;492696.60955085704;492778;493304;50617;52713.7364313176;53469.049023627456;53559.732201338746;53618.46381536213;59086.40913590895;59274.40725592775;59324.703376482845;59353;59523;16113.033218006956;16285.348586056662;16328.83671163297;16346;16355.427560035341;12435.875641243652;12486.562970296178;12508.186967847061;12643.873561264454;12662.683432914251;18390.448286551426;18491.907540462213;18513.44459666212;18513.629727405376;18550.907245463688;7095.716171353191;7197.71209151628;8164.061132969785;8363.540005299645;8367.8326433471;960.2558017536466;967.6419724701906;990.9454979976026;1005.5575546759402;1052.5158427123456;27457;28335.43329133406;28856.855715721285;29011.854940725585;29283.560746588817;957.644932420631;1107.789519991199;1115.9442027898572;1123;1259.6724851538665;14419.279036048365;14537.127772333482;14571.344289506998;14877.776833347509;14954.327055282538;535247;536338;540406.2979685155;540823.295883526;541623;55086;55484.72257638686;55520.444795552336;55536;55573.72213138989;1402.5371627362945;1423.7579611466076;1429.9428022879176;1455.86169313915;1458.6863824277832;27605.895764169207;27797.44405111927;28109;28248.576271355534;28282.575761363183;41091.7945410283;41630.16739665129;41728.37407438952;41738.79130604328;41781.37327940023;296744;305549;306464;307187;307872;27358.726412735617;30756.538651919793;31340.686593134687;31439.528407073456;32062.19844503906;38916.2216755669;39888.40167397433;40377.596224038556;40424.191516168925;40493.39259911045;32059.839700801345;33050.173745655586;33250.33499330048;33840.32319353648;33998.64005439755;32405;32859.83570082134;33099.83450082734;33410;33562.32875342528;33676.49485257772;34235.31529369448;34586;34695.489586353615;34722.78470253529;29077.273068173465;30770.15193473596;30901.69098308988;30936.53595196029;30996.845015774776;23101.65347519822;23252.76747232506;23647.29058128259;23712.170074047324;23760.762392376546 14:36:12 INFO - PROCESS | 1670 | |2;jquery.html;356.55074605996447;358.71661387503866;360.0566515728791;360.8816248620596;370.56828794454464;19615.215391384347;19759.50601234968;20941.47646308843;21002.579948401042;21019.474513137142;19275.518112047204;20074.49813754657;20472.28347007855;20496.487587810312;20522.589548209027;5001.199808030716;5037.1940489521685;5846.766129354821;5920.437558431942;5923.733431995549;4183.184279065584;4335.6748243881675;5843.707814609274;6145.5390845686525;6384.042393640944;6300.558960872718;6334.5249106317215;6334.968325158391;6337.239531256256;6343.0802533632595;5440;6116.602420842653;6411.3588641135975;6416.262129855057;6434.485241180694;3693.1874987502706;5255.76349064293;5466.453354664542;5490.094134467808;5561.4716601923155;23303.650445243336;23467.882660586587;23696.881515592486;25053.37366565832;25120.49759004828;2043.3869839048225;2159.708439360682;2206.150632006689;2257.413072601119;2270.8864556772096;12440.129190956637;12540.623781286577;13632.727345453135;14255.643608909757;14383.640408989859;1406.3319923036477;1674.246589034927;1680.6554656295552;1696.6521863018174;1768.3368736723728;103654;104424;105512;106639.4004089947;107343;10153.441560714231;10380.273380863267;10586.311889727143;10621;10711.78576428467;12661.113722039368;12681.873181268254;12765.489380424679;12765.872341276654;12776.74446511083;6858.554193977376;8184.959075204586;8314.584270786436;8327.541985190752;8409;8595.742127736177;8615.483071015758;8644.481331120152;8694.608742606471;8719.694810681596;6058.4244496772735;6136.417040381157;6139.2325959255095;6157.599756015845;6223.657698826518;1666.6500034992787;1733.1507561295127;1744.110503643151;1785.1788177438264;1849.232568484091;870.2950610005915;882.3955590420583;901.7520181949885;1013.2451323763843;1071.3304184884448;20471;20818.27136050261;20896.164153433998;21095.78904210969;21140.47148821292;977.941323520591;1000.3897622450299;1006.6325791086201;1011.5094179323022;1041.5261056219401;8981.281497480186;11171.05046071093;11286.830697539543;11340;11340.979311861973;501971;564368;620674;625008;625631;102917.94164116676;103106;103861;104320.47839760904;109699.90300096897;820.5158956215861;1029.8867124616286;1036.6889933020063;1041.7135287795766;1042.8852826189113;10503.737406564896;11181;11315.038221751243;17890.463286101436;18513.44459666212;47829.521704783896;48264.10415374948;49157;49938.25092623686;54490.45509544854;64277;65339.673301633185;65417.672911635134;65523.34476655172;65768.6711566439;10918.563257469612;11138.498767555642;11782.764344712887;12044.397780111134;12166.330851803235;13603.795943060664;13811.861881381057;13844.238566878917;14154.575362739135;14209.715805684034;5759.971200143972;11764.294142351486;11783.941080294544;11925.82111268349;12081.852224038703;11398.259113157617;11829.940850296038;11929.403529823649;11978.520859165536;12069.758604827679;8090.959545202236;8178.427510074238;8240.175982401712;8438.409311348147;11845.23006004607;11707.531698732297;11882.940585297018;11975.94012029969;12198.451069702061;12216.816747748613;11749;11792.882071179522;11916.285022898654;12085.637430877088;12113.878861211275 14:36:12 INFO - PROCESS | 1670 | |3;mootools.html;1380.668639526514;1503.188278329702;1522.2160587297544;1715.2538645689126;1881.7741870975485;7829.217078292168;8431.494110353375;8589.527575983318;8598.269147122503;8609.526476043831;8267.751967440987;8544.444611100274;8547.401681882271;8555.3583481239;8585.828283434328;2141.0793358855685;2192.7039849620337;2199.296225207934;2419.9999999999955;2444.4744379958306;2400.459896523286;2472.171822439476;2473.307473907309;2481.1688084491716;2481.4788894332214;2375.429896824758;2415.2754173747894;2429.4776623026046;2430.3924018995253;2436.293474892279;2341.660459233419;2350.71791385034;2358.068562917655;2358.457554762406;2366.4438856868624;2390.8087353011715;2392.509535545209;2394.5450364430876;2406.0255596483453;2410.2287268074224;8605.268552173073;8658.047614762434;8668.176523230282;8670.566471676391;8676.696315628922;4989.550940415344;5377;5428.647137936022;5459.617826752129;5476.835694929158;3487.3722729908604;3512.8594856205723;3655.5796083450477;3664.706823454117;3666.633336666339;1043.89561043895;1044.8641676581997;1064.4677661169414;1067.3222503710122;1072.088724584105;11629.360385178812;11638.767224655545;11639.825402618968;11641;11666.300021998708;3842.3852183650483;4692.4603670577635;4798;4863.294822250754;4863.635227357962;9968.700938971842;10021.749456263506;10025.398476091312;10026.548805303779;10044.34711743749;5391.083515802323;5433.673979561239;5438.537724293479;5459.454054594588;5474.91787623186;4346.326319420495;4514.300283456069;4766.356541866873;4889.633277504201;4964.131277026506;3690.2435000824767;3814.1990182062077;3863.3818589025623;3894.3184942635494;3917.8628747993685;1113.3375641493299;1280.6222164461506;1285.222440423549;1289.8903593194684;1290.3354772292278;1083.285031878972;1111.183280288987;1111.4831603304501;1259.5465632372338;1364.2837510307168;8061;8092.959535202286;8110.3511719062335;8151.918480815235;8243.340532757366;1190.7678002789373;1194.552042983881;1206.6802297391198;1219.5853409840697;1250.6748245456065;6162.26052873649;6233.688315584202;6291.559590828598;6310.652914089769;6323.20959880015;10219.233557483218;10576.259661823753;10714.571417143226;10717.946410268054;10747;9950.55222514974;10239.948800255952;10546.103581195684;10620.893791062144;10764.13886889047;7985.201479852085;8130.878036829452;8141.633626486822;8188.918110819054;8228.794280142925;7924.801879953047;7938.364930805637;7983.720569780262;8129.75610731679;8155.510669359857;9287.257019438564;9509.19171870371;9657.661981830603;9733.270004749813;9964.950175249078;9699.6120155193;9887.505624718879;10063.798724025331;10083.394996299952;10164.33931794431;6527.640979746159;7131.82170445743;7376.188619251985;7380.704771809067;7504.662290196845;8120.269175774209;8124.39067069984;8157.877631835646;8181.386396020203;8195.508269503849;6136.969315153396;7169.605671687898;7244.058272424551;7401.888971665537;7416.66625001887;7131.108611423572;7157.892631610634;7196.604186769778;7321.926780732338;7325.560466372035;7376.4467664926415;7607.961960190164;7615.200403957726;7615.428842836699;7618.314351708373;6853.657317134223;6938.548994315353;6947.756828510978;6963.1644202696;6963.895541566779;5809.186713859978;6986.266442023514;6988.336108069725;7012.614306213003;7035.155781306276 14:36:12 INFO - PROCESS | 1670 | |4;prototype.html;315.03756025342574;324.16527441837275;327.1265720526195;327.77056060757474;331.4117441541264;5921.822345329636;6367.402417634039;6541.705623246953;6656.600603963766;6671.899921501169;6496.1554997850335;6552.049952756847;6563.507736919738;6566.24488183859;6573.539852210347;4706.717596944177;4801.44783349914;4808.447028591704;4872.780724867381;4904.950950490503;4901.754912254373;4920.557149856512;4937.0125974805005;4945.085159245533;4954.355933728628;3944;4858.125537403266;4863.659543831933;4880.048390563841;4896.192128298826;4671.953280467203;4800.87997800056;4822.54185852347;4849.199882019498;4853.587445067174;4145.730527515701;4147.04617937873;4157.542670306264;4160.334346504575;4164.1879833432495;6363.713632886531;6447.709853056624;6457.096006559085;6464.676766161673;6474.870502589922;4478.865634030952;5684.857878553028;5720.685362305072;5725.112607545837;5731.856703582402;5693;5694;7088;7092.858142837114;7095.858082838366;4419.558044195587;4568.0407114506;4599.31010348447;4600.217962946307;4601.217792975169;6502.187226596676;7400.740974065882;7486.887696684554;7552.8867066994035;7570.659320330598;4017.5580686124504;4510.075434535912;4656.371389862393;4660.161170989187;4660.6970546914345;4703.365045718852;4706.1528924793865;4715.3869996900185;4716.504766999485;4717.740524271198;5622.425720798183;5625.071863142617;5626.943730562723;5634.690092044977;5635.21107045014;6927.515073944775;7144.749933752398;7180.8922866157045;7195.676194571257;7197.748078817216;1416.6954104867298;1686.569924669226;1718.4157386488655;1720.1485264794007;1722.7588137660737;1039.142707266508;1066.3335415365398;1105.5190991918541;1106.6443606581872;1130.9934158598853;5400.243965844785;5616.775328986795;6597.86804263912;6728.360805723449;6733.966330168416;7490.026296581518;7505.136909255396;7507.1366792818435;7512.774616761506;7515.398768098539;6687.6321802301345;6704.318272690865;6715.227748808949;6718.428933540606;6719.395254427125;3830.4254361845947;3931.5256778707985;3971.3645816669195;3971.702122340836;3973.264945985002;6407.103005579223;7670;7877.566733829694;7879.881801772978;7887.566183859828;6377.394147555975;6983.546069505466;7609.896564998045;7744.341730952932;7748.65131069092;7779;7814.023247094114;7820.687172513036;7824.491408058458;7826.7651970440975;6051.818445446644;7175.959485874623;7485.663145158372;7491.925080749123;7499.512531685423;7325.963370183115;7359.264073592812;7381.188069312479;7430.44271679637;7449.106107267163;7860.213978602094;7881.960590197013;7883.763487095396;7885.369170466463;7906.248906353887;4630.953690463052;4686.226772582622;4690.366800481891;4693.718376897397;4700.412448443944;6381.968090159519;6999.985002174758;7123.358897699232;7480.4763666544995;7482.588457634883;5804.303483581997;6506.3493650634555;6604.976228684562;7175.2465991070185;7241.4206863451855;5842.737076831638;7200.531965422231;7221.45839062083;7224.169220539705;7228.530145540523;7035.12060992376;7040.260772618802;7048.154221493453;7054.153501579844;7056.788296351117;6957.617331046841;7209.0628218331285;7232.855342893218;7243.348098671145;7246.89129663045;6770.966145169243;6916.723331066701;6917.066196063467;6994.370506654425;7096.680649370894 14:36:12 INFO - PROCESS | 1670 | |5;yui.html;588.4821357205658;630.6720505337223;645.4416929356105;655.672163918041;711.9003339532463;14764.409423623056;14905.180215088192;14929.5521134366;14953.953223274375;16707.415240466587;15357.232138393092;15405;15431.768523472158;15452.304646290915;15457.381704731826;706.261956255714;865.9653613855438;890.8841850559418;893.227358335042;893.8703887936246;709.3013381818904;709.9705427130656;712.9037579926695;713.1940906775336;855.70050482331;915.9587818548148;918.347972939214;919.4575200631626;920.1258804136064;920.6225447566499;907.3965812734524;913.8629205619144;914.2229105260542;914.9634014639406;915.3546749541624;547.5482726750407;555.4417810100863;556.0241775683689;676.3540818518303;680.4352387518348;14769.33537990793;14951.252437378087;14954.327055282538;14958.252087395695;14969.176695281754;12100.273983561014;12158;12170.513179472811;12540.372981350987;12575.308358040304;9806.215502759762;9963.103320701171;9972.501374931297;10232.386056836614;10751.247412681116;3473.1838018065732;3476.5132881396626;3505.088676944013;3550.6483706336776;3586.6413358664186;87085;87732.56133719355;88569.78575535599;89319;89509;9171.494381238226;9315.254779617615;9376.765580860396;9381.577828997712;9398.201152901944;20792.37622871316;20805.271815486387;20814.895925520275;20867.478313042295;21170.682439763415;7151.106111736033;7182.066331376887;7251.166115896739;7267.273272672691;7379.483436159418;4003.11931375097;4017.738846974937;4053.8783836484954;4060.9796951015055;4104.281750693676;3396.2698019925833;3437.810920399402;3438.277961628036;3441.8107004115013;3455.6198818129988;582.118091091996;582.6038293960063;584.7631709157798;591.5356445190505;599.7451083289584;578.9768409263582;580.3326174898816;613.4356392119261;618.8762247550508;625.4391433858789;7837.1379148293645;8037.316828069563;8158.551279679675;8300.294474969694;8424.98900131988;520.6901893373437;572.4161355417451;603.3694788945562;609.774383478116;614.5145335185243;2984.5373967035143;3792.5259342582176;3796.4061747458873;3796.9430458543143;3846.4614953906475;93649.5317523408;93694;94521;94697;94932;80594;80795.59602201951;81615.59192204001;82756.58621706853;82805.17194828096;69734;70580.64709676521;70634.2936570638;70824.64587677029;71262.64368678123;7559.962200189184;7588.62056897164;7736.187700291388;7738.574378409242;7752.224777522202;48181.27728084011;49652.510424687316;49830;50229.497705022484;50307;56130.71934640464;59210.70394647999;63829;69261.65369173122;69574.65212673905;9776.853347199656;9793.657221997197;9882.258830587878;9930.453825039693;10471.476426178508;11932.403379830801;12110.878891210976;12174.634760957186;12574.874251257736;12703.809442858179;11281.32312061279;11287.604933827277;11294.209405341548;11408.657740267805;11701.76596468083;11446.427678616203;11516.539338426704;11525.942370288094;11606.30362178272;11705.531778728755;11124.555017799197;11152.498137583665;11351.262167959056;11424.371659558805;12026.338551379758;9380.390274632127;9614.807703846023;9628;9659.372140810825;9749.56126974302;7768.495047821873;9442.669506567237;9633.614655413705;9754;9775.462349570558 14:36:12 INFO - PROCESS | 1670 | __end_tp_report 14:36:12 INFO - PROCESS | 1670 | __start_cc_report 14:36:12 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1353 14:36:12 INFO - PROCESS | 1670 | __end_cc_report 14:36:12 INFO - PROCESS | 1670 | __startTimestamp1456439772456__endTimestamp 14:36:12 INFO - PROCESS | 1670 | 14:36:12 INFO - PROCESS | 1670 | ------- Summary: start ------- 14:36:12 INFO - PROCESS | 1670 | Number of tests: 6 14:36:12 INFO - PROCESS | 1670 | 14:36:12 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5714.10 Median:5951.55 stddev:641.38 (10.8%) stddev-sans-first:612.17 14:36:12 INFO - PROCESS | 1670 | Values: 3195.9 3416.2 3475.5 3518.2 3518.9 5600.8 5659.7 5670.1 5687.5 5695.7 5180.1 5607.1 5680.0 5683.2 5708.2 4656.0 5161.5 5190.5 5199.2 5281.7 5295.9 5297.4 5297.5 5306.2 5332.8 5201.5 5216.9 5234.6 5255.5 5316.9 5261.4 5287.2 5300.7 5318.6 5354.8 5109.5 5131.6 5146.1 5206.6 5228.5 5538.3 5572.4 5582.3 5588.2 5598.4 6226.7 6238.6 6246.3 6263.0 6264.4 6109.6 6143.5 6260.3 6270.8 6321.6 5801.4 5803.1 5825.9 5840.6 5861.7 6266.9 6306.2 6314.7 6315.6 6327.9 6023.7 6115.8 6126.1 6162.5 6198.3 6186.1 6205.2 6220.9 6234.4 6251.5 6147.2 6181.8 6202.9 6213.4 6225.1 6091.5 6123.1 6142.6 6159.2 6171.9 4885.9 4887.5 4890.6 4907.9 4933.1 4299.6 4436.1 4437.7 4455.3 4482.0 5574.1 5638.5 5662.9 5702.0 5725.0 6283.2 6285.0 6287.1 6290.1 6308.0 5581.9 5654.7 5666.7 5669.7 5679.0 5306.1 5309.0 5327.7 5328.0 5346.7 6273.8 6328.9 6333.5 6338.2 6352.9 6261.0 6299.6 6327.7 6330.5 6331.8 6153.8 6214.4 6299.8 6326.3 6330.3 6149.4 6166.9 6203.8 6207.6 6216.8 5228.2 5790.8 6237.5 6272.3 6274.5 5879.4 6026.8 6038.2 6045.8 6050.9 4654.6 4998.2 5948.6 6132.4 6138.7 5965.2 5973.5 5978.6 5979.2 5980.5 5951.6 6019.5 6102.6 6121.8 6146.2 5947.7 6011.9 6015.7 6019.7 6048.5 14:36:12 INFO - PROCESS | 1670 | 14:36:12 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:57961.53 Median:33919.48 stddev:121737.98 (358.9%) stddev-sans-first:122002.99 14:36:12 INFO - PROCESS | 1670 | Values: 480.2 502.6 504.5 527.0 604.5 28693.0 29108.7 29129.6 29159.3 29177.9 29871.0 37695.4 38259.4 38261.0 38403.4 9330.5 9483.6 9512.6 9518.3 9523.1 9294.3 9432.8 9435.2 9443.7 9448.6 9395.1 9471.5 9478.9 9486.8 9606.8 9473.7 9562.0 9565.2 9575.5 9582.0 8059.5 9335.2 9464.9 9474.6 9474.6 38327.8 38759.2 38787.4 38790.6 38838.6 3147.7 3268.4 3332.6 3345.8 3554.2 27396.9 28312.0 28978.6 29048.4 29083.0 2685.0 2754.1 2756.3 2776.2 2800.3 488814.0 492428.0 492696.6 492778.0 493304.0 50617.0 52713.7 53469.0 53559.7 53618.5 59086.4 59274.4 59324.7 59353.0 59523.0 16113.0 16285.3 16328.8 16346.0 16355.4 12435.9 12486.6 12508.2 12643.9 12662.7 18390.4 18491.9 18513.4 18513.6 18550.9 7095.7 7197.7 8164.1 8363.5 8367.8 960.3 967.6 990.9 1005.6 1052.5 27457.0 28335.4 28856.9 29011.9 29283.6 957.6 1107.8 1115.9 1123.0 1259.7 14419.3 14537.1 14571.3 14877.8 14954.3 535247.0 536338.0 540406.3 540823.3 541623.0 55086.0 55484.7 55520.4 55536.0 55573.7 1402.5 1423.8 1429.9 1455.9 1458.7 27605.9 27797.4 28109.0 28248.6 28282.6 41091.8 41630.2 41728.4 41738.8 41781.4 296744.0 305549.0 306464.0 307187.0 307872.0 27358.7 30756.5 31340.7 31439.5 32062.2 38916.2 39888.4 40377.6 40424.2 40493.4 32059.8 33050.2 33250.3 33840.3 33998.6 32405.0 32859.8 33099.8 33410.0 33562.3 33676.5 34235.3 34586.0 34695.5 34722.8 29077.3 30770.2 30901.7 30936.5 30996.8 23101.7 23252.8 23647.3 23712.2 23760.8 14:36:12 INFO - PROCESS | 1670 | 14:36:12 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:33366.80 Median:20484.39 stddev:97495.16 (475.9%) stddev-sans-first:97737.15 14:36:12 INFO - PROCESS | 1670 | Values: 356.6 358.7 360.1 360.9 370.6 19615.2 19759.5 20941.5 21002.6 21019.5 19275.5 20074.5 20472.3 20496.5 20522.6 5001.2 5037.2 5846.8 5920.4 5923.7 4183.2 4335.7 5843.7 6145.5 6384.0 6300.6 6334.5 6335.0 6337.2 6343.1 5440.0 6116.6 6411.4 6416.3 6434.5 3693.2 5255.8 5466.5 5490.1 5561.5 23303.7 23467.9 23696.9 25053.4 25120.5 2043.4 2159.7 2206.2 2257.4 2270.9 12440.1 12540.6 13632.7 14255.6 14383.6 1406.3 1674.2 1680.7 1696.7 1768.3 103654.0 104424.0 105512.0 106639.4 107343.0 10153.4 10380.3 10586.3 10621.0 10711.8 12661.1 12681.9 12765.5 12765.9 12776.7 6858.6 8185.0 8314.6 8327.5 8409.0 8595.7 8615.5 8644.5 8694.6 8719.7 6058.4 6136.4 6139.2 6157.6 6223.7 1666.7 1733.2 1744.1 1785.2 1849.2 870.3 882.4 901.8 1013.2 1071.3 20471.0 20818.3 20896.2 21095.8 21140.5 977.9 1000.4 1006.6 1011.5 1041.5 8981.3 11171.1 11286.8 11340.0 11341.0 501971.0 564368.0 620674.0 625008.0 625631.0 102917.9 103106.0 103861.0 104320.5 109699.9 820.5 1029.9 1036.7 1041.7 1042.9 10503.7 11181.0 11315.0 17890.5 18513.4 47829.5 48264.1 49157.0 49938.3 54490.5 64277.0 65339.7 65417.7 65523.3 65768.7 10918.6 11138.5 11782.8 12044.4 12166.3 13603.8 13811.9 13844.2 14154.6 14209.7 5760.0 11764.3 11783.9 11925.8 12081.9 11398.3 11829.9 11929.4 11978.5 12069.8 8091.0 8178.4 8240.2 8438.4 11845.2 11707.5 11882.9 11975.9 12198.5 12216.8 11749.0 11792.9 11916.3 12085.6 12113.9 14:36:12 INFO - PROCESS | 1670 | 14:36:12 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5974.21 Median:4976.84 stddev:3156.19 (63.4%) stddev-sans-first:3146.15 14:36:12 INFO - PROCESS | 1670 | Values: 1380.7 1503.2 1522.2 1715.3 1881.8 7829.2 8431.5 8589.5 8598.3 8609.5 8267.8 8544.4 8547.4 8555.4 8585.8 2141.1 2192.7 2199.3 2420.0 2444.5 2400.5 2472.2 2473.3 2481.2 2481.5 2375.4 2415.3 2429.5 2430.4 2436.3 2341.7 2350.7 2358.1 2358.5 2366.4 2390.8 2392.5 2394.5 2406.0 2410.2 8605.3 8658.0 8668.2 8670.6 8676.7 4989.6 5377.0 5428.6 5459.6 5476.8 3487.4 3512.9 3655.6 3664.7 3666.6 1043.9 1044.9 1064.5 1067.3 1072.1 11629.4 11638.8 11639.8 11641.0 11666.3 3842.4 4692.5 4798.0 4863.3 4863.6 9968.7 10021.7 10025.4 10026.5 10044.3 5391.1 5433.7 5438.5 5459.5 5474.9 4346.3 4514.3 4766.4 4889.6 4964.1 3690.2 3814.2 3863.4 3894.3 3917.9 1113.3 1280.6 1285.2 1289.9 1290.3 1083.3 1111.2 1111.5 1259.5 1364.3 8061.0 8093.0 8110.4 8151.9 8243.3 1190.8 1194.6 1206.7 1219.6 1250.7 6162.3 6233.7 6291.6 6310.7 6323.2 10219.2 10576.3 10714.6 10717.9 10747.0 9950.6 10239.9 10546.1 10620.9 10764.1 7985.2 8130.9 8141.6 8188.9 8228.8 7924.8 7938.4 7983.7 8129.8 8155.5 9287.3 9509.2 9657.7 9733.3 9965.0 9699.6 9887.5 10063.8 10083.4 10164.3 6527.6 7131.8 7376.2 7380.7 7504.7 8120.3 8124.4 8157.9 8181.4 8195.5 6137.0 7169.6 7244.1 7401.9 7416.7 7131.1 7157.9 7196.6 7321.9 7325.6 7376.4 7608.0 7615.2 7615.4 7618.3 6853.7 6938.5 6947.8 6963.2 6963.9 5809.2 6986.3 6988.3 7012.6 7035.2 14:36:12 INFO - PROCESS | 1670 | 14:36:12 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5769.32 Median:6469.77 stddev:1867.27 (28.9%) stddev-sans-first:1827.08 14:36:12 INFO - PROCESS | 1670 | Values: 315.0 324.2 327.1 327.8 331.4 5921.8 6367.4 6541.7 6656.6 6671.9 6496.2 6552.0 6563.5 6566.2 6573.5 4706.7 4801.4 4808.4 4872.8 4905.0 4901.8 4920.6 4937.0 4945.1 4954.4 3944.0 4858.1 4863.7 4880.0 4896.2 4672.0 4800.9 4822.5 4849.2 4853.6 4145.7 4147.0 4157.5 4160.3 4164.2 6363.7 6447.7 6457.1 6464.7 6474.9 4478.9 5684.9 5720.7 5725.1 5731.9 5693.0 5694.0 7088.0 7092.9 7095.9 4419.6 4568.0 4599.3 4600.2 4601.2 6502.2 7400.7 7486.9 7552.9 7570.7 4017.6 4510.1 4656.4 4660.2 4660.7 4703.4 4706.2 4715.4 4716.5 4717.7 5622.4 5625.1 5626.9 5634.7 5635.2 6927.5 7144.7 7180.9 7195.7 7197.7 1416.7 1686.6 1718.4 1720.1 1722.8 1039.1 1066.3 1105.5 1106.6 1131.0 5400.2 5616.8 6597.9 6728.4 6734.0 7490.0 7505.1 7507.1 7512.8 7515.4 6687.6 6704.3 6715.2 6718.4 6719.4 3830.4 3931.5 3971.4 3971.7 3973.3 6407.1 7670.0 7877.6 7879.9 7887.6 6377.4 6983.5 7609.9 7744.3 7748.7 7779.0 7814.0 7820.7 7824.5 7826.8 6051.8 7176.0 7485.7 7491.9 7499.5 7326.0 7359.3 7381.2 7430.4 7449.1 7860.2 7882.0 7883.8 7885.4 7906.2 4631.0 4686.2 4690.4 4693.7 4700.4 6382.0 7000.0 7123.4 7480.5 7482.6 5804.3 6506.3 6605.0 7175.2 7241.4 5842.7 7200.5 7221.5 7224.2 7228.5 7035.1 7040.3 7048.2 7054.2 7056.8 6957.6 7209.1 7232.9 7243.3 7246.9 6771.0 6916.7 6917.1 6994.4 7096.7 14:36:12 INFO - PROCESS | 1670 | 14:36:12 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18507.12 Median:613.98 stddev:26488.66 (4314.3%) stddev-sans-first:26528.80 14:36:12 INFO - PROCESS | 1670 | Values: 588.5 630.7 645.4 655.7 711.9 14764.4 14905.2 14929.6 14954.0 16707.4 15357.2 15405.0 15431.8 15452.3 15457.4 706.3 866.0 890.9 893.2 893.9 709.3 710.0 712.9 713.2 855.7 916.0 918.3 919.5 920.1 920.6 907.4 913.9 914.2 915.0 915.4 547.5 555.4 556.0 676.4 680.4 14769.3 14951.3 14954.3 14958.3 14969.2 12100.3 12158.0 12170.5 12540.4 12575.3 9806.2 9963.1 9972.5 10232.4 10751.2 3473.2 3476.5 3505.1 3550.6 3586.6 87085.0 87732.6 88569.8 89319.0 89509.0 9171.5 9315.3 9376.8 9381.6 9398.2 20792.4 20805.3 20814.9 20867.5 21170.7 7151.1 7182.1 7251.2 7267.3 7379.5 4003.1 4017.7 4053.9 4061.0 4104.3 3396.3 3437.8 3438.3 3441.8 3455.6 582.1 582.6 584.8 591.5 599.7 579.0 580.3 613.4 618.9 625.4 7837.1 8037.3 8158.6 8300.3 8425.0 520.7 572.4 603.4 609.8 614.5 2984.5 3792.5 3796.4 3796.9 3846.5 93649.5 93694.0 94521.0 94697.0 94932.0 80594.0 80795.6 81615.6 82756.6 82805.2 69734.0 70580.6 70634.3 70824.6 71262.6 7560.0 7588.6 7736.2 7738.6 7752.2 48181.3 49652.5 49830.0 50229.5 50307.0 56130.7 59210.7 63829.0 69261.7 69574.7 9776.9 9793.7 9882.3 9930.5 10471.5 11932.4 12110.9 12174.6 12574.9 12703.8 11281.3 11287.6 11294.2 11408.7 11701.8 11446.4 11516.5 11525.9 11606.3 11705.5 11124.6 11152.5 11351.3 11424.4 12026.3 9380.4 9614.8 9628.0 9659.4 9749.6 7768.5 9442.7 9633.6 9754.0 9775.5 14:36:12 INFO - PROCESS | 1670 | -------- Summary: end -------- 14:36:12 INFO - PROCESS | 1670 | 14:36:12 INFO - TEST-INFO | 1670: exit 0 14:36:12 INFO - TEST-OK | dromaeo_css | took 1113005ms 14:36:12 INFO - TEST-START | kraken 14:36:12 INFO - operating with platform_type : mac_ 14:36:12 INFO - Initialising browser for kraken test... 14:36:12 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpRMOVnY/profile http://localhost:49280/getInfo.html) 14:36:15 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 14:36:15 INFO - PROCESS | 1680 | colorDepth:24 14:36:15 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 14:36:15 INFO - PROCESS | 1680 | __metrics 14:36:15 INFO - PROCESS | 1680 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:36:15 INFO - PROCESS | 1680 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:36:15 INFO - TEST-INFO | 1680: exit 0 14:36:15 INFO - Browser initialized. 14:36:15 INFO - Running cycle 1/1 for kraken test... 14:36:15 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpRMOVnY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:27 INFO - PROCESS | 1682 | RSS: Main: 244338688 14:36:27 INFO - PROCESS | 1682 | 14:36:30 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 14:36:30 INFO - PROCESS | 1682 | RSS: Main: 291344384 14:36:30 INFO - PROCESS | 1682 | 14:36:33 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 14:36:34 INFO - PROCESS | 1682 | RSS: Main: 302387200 14:36:34 INFO - PROCESS | 1682 | 14:36:37 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 14:36:37 INFO - PROCESS | 1682 | RSS: Main: 288100352 14:36:37 INFO - PROCESS | 1682 | 14:36:39 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 14:36:40 INFO - PROCESS | 1682 | RSS: Main: 289542144 14:36:40 INFO - PROCESS | 1682 | 14:36:42 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:36:43 INFO - PROCESS | 1682 | RSS: Main: 292311040 14:36:43 INFO - PROCESS | 1682 | 14:36:45 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 14:36:46 INFO - PROCESS | 1682 | RSS: Main: 291123200 14:36:46 INFO - PROCESS | 1682 | 14:36:49 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 14:36:49 INFO - PROCESS | 1682 | RSS: Main: 292106240 14:36:49 INFO - PROCESS | 1682 | 14:36:52 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 14:36:53 INFO - PROCESS | 1682 | RSS: Main: 293425152 14:36:53 INFO - PROCESS | 1682 | 14:36:54 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:36:55 INFO - PROCESS | 1682 | RSS: Main: 325021696 14:36:55 INFO - PROCESS | 1682 | 14:36:57 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:36:57 INFO - PROCESS | 1682 | RSS: Main: 324694016 14:36:57 INFO - PROCESS | 1682 | 14:36:59 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:37:00 INFO - PROCESS | 1682 | RSS: Main: 332480512 14:37:00 INFO - PROCESS | 1682 | 14:37:03 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:37:03 INFO - PROCESS | 1682 | RSS: Main: 333811712 14:37:03 INFO - PROCESS | 1682 | 14:37:06 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:37:06 INFO - PROCESS | 1682 | RSS: Main: 333795328 14:37:06 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 14:37:08 INFO - PROCESS | 1682 | RSS: Main: 394067968 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | __start_tp_report 14:37:08 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 14:37:08 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 14:37:08 INFO - PROCESS | 1682 | |i|pagename|runs| 14:37:08 INFO - PROCESS | 1682 | |0;ai-astar;110;108;112;108;109;110;116;110;111;110 14:37:08 INFO - PROCESS | 1682 | |1;audio-beat-detection;155;121;154;156;121;142;141;112;162;118 14:37:08 INFO - PROCESS | 1682 | |2;audio-dft;185;184;185;184;183;182;183;185;182;182 14:37:08 INFO - PROCESS | 1682 | |3;audio-fft;77;75;85;76;55;58;58;78;76;55 14:37:08 INFO - PROCESS | 1682 | |4;audio-oscillator;91;92;132;79;80;87;100;75;119;151 14:37:08 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;83;90;84;91;84;89;84;90;83;90 14:37:08 INFO - PROCESS | 1682 | |6;imaging-darkroom;94;93;93;94;92;94;93;92;94;94 14:37:08 INFO - PROCESS | 1682 | |7;imaging-desaturate;87;86;88;87;85;87;104;135;144;85 14:37:08 INFO - PROCESS | 1682 | |8;json-parse-financial;57;57;55;53;54;56;54;63;59;77 14:37:08 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;63;67;72;73;69;67;66;66;68;67 14:37:08 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;98;107;94;82;82;82;82;81;84;82 14:37:08 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;124;122;141;131;127;113;123;121;117;129 14:37:08 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;137;137;137;134;139;125;137;139;134;135 14:37:08 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;66;66;66;65;66;67;65;65;67;67 14:37:08 INFO - PROCESS | 1682 | __end_tp_report 14:37:08 INFO - PROCESS | 1682 | __start_cc_report 14:37:08 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1244 14:37:08 INFO - PROCESS | 1682 | __end_cc_report 14:37:08 INFO - PROCESS | 1682 | __startTimestamp1456439828608__endTimestamp 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | ------- Summary: start ------- 14:37:08 INFO - PROCESS | 1682 | Number of tests: 14 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.00 stddev:2.32 (2.1%) stddev-sans-first:2.46 14:37:08 INFO - PROCESS | 1682 | Values: 110.0 108.0 112.0 108.0 109.0 110.0 116.0 110.0 111.0 110.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:148.00 stddev:18.63 (12.6%) stddev-sans-first:18.74 14:37:08 INFO - PROCESS | 1682 | Values: 155.0 121.0 154.0 156.0 121.0 142.0 141.0 112.0 162.0 118.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.27 (0.7%) stddev-sans-first:1.22 14:37:08 INFO - PROCESS | 1682 | Values: 185.0 184.0 185.0 184.0 183.0 182.0 183.0 185.0 182.0 182.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:69.30 Median:76.00 stddev:11.39 (15.0%) stddev-sans-first:11.74 14:37:08 INFO - PROCESS | 1682 | Values: 77.0 75.0 85.0 76.0 55.0 58.0 58.0 78.0 76.0 55.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:79.50 stddev:25.30 (31.8%) stddev-sans-first:26.60 14:37:08 INFO - PROCESS | 1682 | Values: 91.0 92.0 132.0 79.0 80.0 87.0 100.0 75.0 119.0 151.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:89.50 stddev:3.43 (3.8%) stddev-sans-first:3.35 14:37:08 INFO - PROCESS | 1682 | Values: 83.0 90.0 84.0 91.0 84.0 89.0 84.0 90.0 83.0 90.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 14:37:08 INFO - PROCESS | 1682 | Values: 94.0 93.0 93.0 94.0 92.0 94.0 93.0 92.0 94.0 94.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:98.80 Median:86.50 stddev:22.26 (25.7%) stddev-sans-first:23.20 14:37:08 INFO - PROCESS | 1682 | Values: 87.0 86.0 88.0 87.0 85.0 87.0 104.0 135.0 144.0 85.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:57.00 stddev:7.12 (12.5%) stddev-sans-first:7.53 14:37:08 INFO - PROCESS | 1682 | Values: 57.0 57.0 55.0 53.0 54.0 56.0 54.0 63.0 59.0 77.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.50 stddev:2.94 (4.4%) stddev-sans-first:2.55 14:37:08 INFO - PROCESS | 1682 | Values: 63.0 67.0 72.0 73.0 69.0 67.0 66.0 66.0 68.0 67.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:82.00 stddev:9.06 (11.0%) stddev-sans-first:8.76 14:37:08 INFO - PROCESS | 1682 | Values: 98.0 107.0 94.0 82.0 82.0 82.0 82.0 81.0 84.0 82.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:125.50 stddev:7.81 (6.2%) stddev-sans-first:8.28 14:37:08 INFO - PROCESS | 1682 | Values: 124.0 122.0 141.0 131.0 127.0 113.0 123.0 121.0 117.0 129.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.40 Median:137.00 stddev:4.06 (3.0%) stddev-sans-first:4.27 14:37:08 INFO - PROCESS | 1682 | Values: 137.0 137.0 137.0 134.0 139.0 125.0 137.0 139.0 134.0 135.0 14:37:08 INFO - PROCESS | 1682 | 14:37:08 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 14:37:08 INFO - PROCESS | 1682 | Values: 66.0 66.0 66.0 65.0 66.0 67.0 65.0 65.0 67.0 67.0 14:37:08 INFO - PROCESS | 1682 | -------- Summary: end -------- 14:37:08 INFO - PROCESS | 1682 | 14:37:09 INFO - TEST-INFO | 1682: exit 0 14:37:09 INFO - TEST-OK | kraken | took 56401ms 14:37:09 INFO - SUITE-END | took 1169s 14:37:09 INFO - Completed test suite (00:19:29) 14:37:09 INFO - Working with test: dromaeo_css 14:37:09 INFO - Generating results file: dromaeo_css 14:37:09 INFO - Working with test: kraken 14:37:09 INFO - Generating results file: kraken 14:37:09 INFO - javascript benchmark 14:37:09 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:09 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 14:37:09 INFO - process_Request line: dromaeo_css 7440.80 graph.html#tests=[[72,64,59]] 14:37:09 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:09 INFO - process_Request line: kraken 1420.80 graph.html#tests=[[232,64,59]] 14:37:09 INFO - RETURN: dromaeo_css: 7440.80 14:37:09 INFO - RETURN: kraken: 1420.80 14:37:09 INFO - javascript benchmark 14:37:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3195.9360812783743, 3416.19719365949, 3475.461303497959, 3518.225990282138, 3518.912027199318, 5600.775968961247, 5659.717014149297, 5670.14947757836, 5687.544996400288, 5695.686737229451, 5180.119379705449, 5607.130894711316, 5680.034394153004, 5683.175939488771, 5708.20085188074, 4655.976720116403, 5161.535461808437, 5190.506901844319, 5199.194124910645, 5281.735913204344, 5295.947040529584, 5297.390800057985, 5297.549708274802, 5306.151015837467, 5332.786688532454, 5201.531862132408, 5216.895662086756, 5234.6335756497065, 5255.500727430907, 5316.946830531703, 5261.421243663194, 5287.206918962167, 5300.708461034642, 5318.601104917147, 5354.839354819323, 5109.540141387293, 5131.61512886535, 5146.125158723026, 5206.557442617382, 5228.451012643655, 5538.335399752015, 5572.4148964358565, 5582.330120385539, 5588.21764952907, 5598.384177740486, 6226.688665566749, 6238.625682459067, 6246.344133865924, 6263.029230469285, 6264.404881536247, 6109.5723299369065, 6143.542582966805, 6260.342664020303, 6270.78052268173, 6321.620702757803, 5801.419858014249, 5803.100519419497, 5825.883482330372, 5840.649561026267, 5861.736221870026, 6266.893483640915, 6306.180196574416, 6314.684265786692, 6315.5579109462815, 6327.905081423783, 6023.69881505923, 6115.847103822351, 6126.081087836771, 6162.506999440034, 6198.256209254918, 6186.133941248228, 6205.22434695663, 6220.937790622126, 6234.376562343729, 6251.531135164881, 6147.200863887755, 6181.81454556364, 6202.937970620236, 6213.440790328892, 6225.066240064027, 6091.543134264948, 6123.081537769282, 6142.621558143003, 6159.168512250789, 6171.876562468726, 4885.853424397274, 4887.511248875084, 4890.58430033444, 4907.901841963141, 4933.087378834927, 4299.570042995738, 4436.134953684001, 4437.689361744711, 4455.309427038814, 4481.955180448153, 5574.080276754371, 5638.520725738276, 5662.943370566241, 5702.030654788696, 5725.0, 6283.2460104787715, 6285.025820997753, 6287.088372186007, 6290.087937249074, 6307.990721484541, 5581.916271255935, 5654.6889921054735, 5666.716664166775, 5669.659820410706, 5678.971605141948, 5306.09796334624, 5308.9734551327765, 5327.7336133193185, 5327.9733601331745, 5346.652467589672, 6273.843153921189, 6328.936710632835, 6333.46165575922, 6338.176037115146, 6352.872942541123, 6261.029540421242, 6299.559030867978, 6327.746890124344, 6330.49356051524, 6331.841703957438, 6153.846153846011, 6214.40963108504, 6299.811005669837, 6326.335734747785, 6330.335314791881, 6149.41580549847, 6166.907496387468, 6203.751849925952, 6207.596506227081, 6216.844578885564, 5228.215767634885, 5790.768369265183, 6237.4698150657705, 6272.341404152498, 6274.529410294337, 5879.412058794086, 6026.758929642765, 6038.215032045806, 6045.758169673164, 6050.9394906050375, 4654.604358629555, 4998.225275082368, 5948.583599148018, 6132.41742034506, 6138.693065346804, 5965.194698715618, 5973.49225315853, 5978.641281523122, 5979.162917191509, 5980.491658209101, 5951.553633477593, 6019.458248757633, 6102.567671004098, 6121.816345509642, 6146.231721034871, 5947.732352044082, 6011.909821352596, 6015.729292181775, 6019.668918209541, 6048.546359023179], "unit": "score", "name": "dojo.html", "value": 5674.302097757921}, {"lowerIsBetter": false, "replicates": [480.169307098719, 502.63056653359774, 504.45266885429305, 526.9604779641528, 604.4801470735168, 28693.0, 29108.708912910864, 29129.563056554114, 29159.271018224554, 29177.854110729415, 29871.0, 37695.4345684815, 38259.42610860839, 38261.0, 38403.423948640724, 9330.53347332634, 9483.573239204217, 9512.619495220182, 9518.286128540352, 9523.095305945924, 9294.256459483258, 9432.81134377312, 9435.15083642472, 9443.716688499357, 9448.57481413338, 9395.06049395062, 9471.47906865122, 9478.905210947905, 9486.762830929247, 9606.80786384272, 9473.668421605245, 9561.952190239073, 9565.234781217487, 9575.473348965805, 9581.999999999965, 8059.5164290142775, 9335.159835614759, 9464.858027129598, 9474.573644185959, 9474.573644186028, 38327.80836095801, 38759.22481550381, 38787.41818872719, 38790.61209387898, 38838.61161388378, 3147.6537580866316, 3268.3790079884748, 3332.6167490738635, 3345.7657963942534, 3554.2358392945384, 27396.863015684794, 28312.009079682113, 28978.565321520193, 29048.41903161946, 29083.0, 2684.9731502685113, 2754.077384076337, 2756.2558109310376, 2776.1671498550354, 2800.271929298397, 488814.0, 492428.0, 492696.60955085704, 492778.0, 493304.0, 50617.0, 52713.7364313176, 53469.049023627456, 53559.732201338746, 53618.46381536213, 59086.40913590895, 59274.40725592775, 59324.703376482845, 59353.0, 59523.0, 16113.033218006956, 16285.348586056662, 16328.83671163297, 16346.0, 16355.427560035341, 12435.875641243652, 12486.562970296178, 12508.186967847061, 12643.873561264454, 12662.683432914251, 18390.448286551426, 18491.907540462213, 18513.44459666212, 18513.629727405376, 18550.907245463688, 7095.716171353191, 7197.71209151628, 8164.061132969785, 8363.540005299645, 8367.8326433471, 960.2558017536466, 967.6419724701906, 990.9454979976026, 1005.5575546759402, 1052.5158427123456, 27457.0, 28335.43329133406, 28856.855715721285, 29011.854940725585, 29283.560746588817, 957.644932420631, 1107.789519991199, 1115.9442027898572, 1123.0, 1259.6724851538665, 14419.279036048365, 14537.127772333482, 14571.344289506998, 14877.776833347509, 14954.327055282538, 535247.0, 536338.0, 540406.2979685155, 540823.295883526, 541623.0, 55086.0, 55484.72257638686, 55520.444795552336, 55536.0, 55573.72213138989, 1402.5371627362945, 1423.7579611466076, 1429.9428022879176, 1455.86169313915, 1458.6863824277832, 27605.895764169207, 27797.44405111927, 28109.0, 28248.576271355534, 28282.575761363183, 41091.7945410283, 41630.16739665129, 41728.37407438952, 41738.79130604328, 41781.37327940023, 296744.0, 305549.0, 306464.0, 307187.0, 307872.0, 27358.726412735617, 30756.538651919793, 31340.686593134687, 31439.528407073456, 32062.19844503906, 38916.2216755669, 39888.40167397433, 40377.596224038556, 40424.191516168925, 40493.39259911045, 32059.839700801345, 33050.173745655586, 33250.33499330048, 33840.32319353648, 33998.64005439755, 32405.0, 32859.83570082134, 33099.83450082734, 33410.0, 33562.32875342528, 33676.49485257772, 34235.31529369448, 34586.0, 34695.489586353615, 34722.78470253529, 29077.273068173465, 30770.15193473596, 30901.69098308988, 30936.53595196029, 30996.845015774776, 23101.65347519822, 23252.76747232506, 23647.29058128259, 23712.170074047324, 23760.762392376546], "unit": "score", "name": "ext.html", "value": 18539.55079253078}, {"lowerIsBetter": false, "replicates": [356.55074605996447, 358.71661387503866, 360.0566515728791, 360.8816248620596, 370.56828794454464, 19615.215391384347, 19759.50601234968, 20941.47646308843, 21002.579948401042, 21019.474513137142, 19275.518112047204, 20074.49813754657, 20472.28347007855, 20496.487587810312, 20522.589548209027, 5001.199808030716, 5037.1940489521685, 5846.766129354821, 5920.437558431942, 5923.733431995549, 4183.184279065584, 4335.6748243881675, 5843.707814609274, 6145.5390845686525, 6384.042393640944, 6300.558960872718, 6334.5249106317215, 6334.968325158391, 6337.239531256256, 6343.0802533632595, 5440.0, 6116.602420842653, 6411.3588641135975, 6416.262129855057, 6434.485241180694, 3693.1874987502706, 5255.76349064293, 5466.453354664542, 5490.094134467808, 5561.4716601923155, 23303.650445243336, 23467.882660586587, 23696.881515592486, 25053.37366565832, 25120.49759004828, 2043.3869839048225, 2159.708439360682, 2206.150632006689, 2257.413072601119, 2270.8864556772096, 12440.129190956637, 12540.623781286577, 13632.727345453135, 14255.643608909757, 14383.640408989859, 1406.3319923036477, 1674.246589034927, 1680.6554656295552, 1696.6521863018174, 1768.3368736723728, 103654.0, 104424.0, 105512.0, 106639.4004089947, 107343.0, 10153.441560714231, 10380.273380863267, 10586.311889727143, 10621.0, 10711.78576428467, 12661.113722039368, 12681.873181268254, 12765.489380424679, 12765.872341276654, 12776.74446511083, 6858.554193977376, 8184.959075204586, 8314.584270786436, 8327.541985190752, 8409.0, 8595.742127736177, 8615.483071015758, 8644.481331120152, 8694.608742606471, 8719.694810681596, 6058.4244496772735, 6136.417040381157, 6139.2325959255095, 6157.599756015845, 6223.657698826518, 1666.6500034992787, 1733.1507561295127, 1744.110503643151, 1785.1788177438264, 1849.232568484091, 870.2950610005915, 882.3955590420583, 901.7520181949885, 1013.2451323763843, 1071.3304184884448, 20471.0, 20818.27136050261, 20896.164153433998, 21095.78904210969, 21140.47148821292, 977.941323520591, 1000.3897622450299, 1006.6325791086201, 1011.5094179323022, 1041.5261056219401, 8981.281497480186, 11171.05046071093, 11286.830697539543, 11340.0, 11340.979311861973, 501971.0, 564368.0, 620674.0, 625008.0, 625631.0, 102917.94164116676, 103106.0, 103861.0, 104320.47839760904, 109699.90300096897, 820.5158956215861, 1029.8867124616286, 1036.6889933020063, 1041.7135287795766, 1042.8852826189113, 10503.737406564896, 11181.0, 11315.038221751243, 17890.463286101436, 18513.44459666212, 47829.521704783896, 48264.10415374948, 49157.0, 49938.25092623686, 54490.45509544854, 64277.0, 65339.673301633185, 65417.672911635134, 65523.34476655172, 65768.6711566439, 10918.563257469612, 11138.498767555642, 11782.764344712887, 12044.397780111134, 12166.330851803235, 13603.795943060664, 13811.861881381057, 13844.238566878917, 14154.575362739135, 14209.715805684034, 5759.971200143972, 11764.294142351486, 11783.941080294544, 11925.82111268349, 12081.852224038703, 11398.259113157617, 11829.940850296038, 11929.403529823649, 11978.520859165536, 12069.758604827679, 8090.959545202236, 8178.427510074238, 8240.175982401712, 8438.409311348147, 11845.23006004607, 11707.531698732297, 11882.940585297018, 11975.94012029969, 12198.451069702061, 12216.816747748613, 11749.0, 11792.882071179522, 11916.285022898654, 12085.637430877088, 12113.878861211275], "unit": "score", "name": "jquery.html", "value": 9522.041365069364}, {"lowerIsBetter": false, "replicates": [1380.668639526514, 1503.188278329702, 1522.2160587297544, 1715.2538645689126, 1881.7741870975485, 7829.217078292168, 8431.494110353375, 8589.527575983318, 8598.269147122503, 8609.526476043831, 8267.751967440987, 8544.444611100274, 8547.401681882271, 8555.3583481239, 8585.828283434328, 2141.0793358855685, 2192.7039849620337, 2199.296225207934, 2419.9999999999955, 2444.4744379958306, 2400.459896523286, 2472.171822439476, 2473.307473907309, 2481.1688084491716, 2481.4788894332214, 2375.429896824758, 2415.2754173747894, 2429.4776623026046, 2430.3924018995253, 2436.293474892279, 2341.660459233419, 2350.71791385034, 2358.068562917655, 2358.457554762406, 2366.4438856868624, 2390.8087353011715, 2392.509535545209, 2394.5450364430876, 2406.0255596483453, 2410.2287268074224, 8605.268552173073, 8658.047614762434, 8668.176523230282, 8670.566471676391, 8676.696315628922, 4989.550940415344, 5377.0, 5428.647137936022, 5459.617826752129, 5476.835694929158, 3487.3722729908604, 3512.8594856205723, 3655.5796083450477, 3664.706823454117, 3666.633336666339, 1043.89561043895, 1044.8641676581997, 1064.4677661169414, 1067.3222503710122, 1072.088724584105, 11629.360385178812, 11638.767224655545, 11639.825402618968, 11641.0, 11666.300021998708, 3842.3852183650483, 4692.4603670577635, 4798.0, 4863.294822250754, 4863.635227357962, 9968.700938971842, 10021.749456263506, 10025.398476091312, 10026.548805303779, 10044.34711743749, 5391.083515802323, 5433.673979561239, 5438.537724293479, 5459.454054594588, 5474.91787623186, 4346.326319420495, 4514.300283456069, 4766.356541866873, 4889.633277504201, 4964.131277026506, 3690.2435000824767, 3814.1990182062077, 3863.3818589025623, 3894.3184942635494, 3917.8628747993685, 1113.3375641493299, 1280.6222164461506, 1285.222440423549, 1289.8903593194684, 1290.3354772292278, 1083.285031878972, 1111.183280288987, 1111.4831603304501, 1259.5465632372338, 1364.2837510307168, 8061.0, 8092.959535202286, 8110.3511719062335, 8151.918480815235, 8243.340532757366, 1190.7678002789373, 1194.552042983881, 1206.6802297391198, 1219.5853409840697, 1250.6748245456065, 6162.26052873649, 6233.688315584202, 6291.559590828598, 6310.652914089769, 6323.20959880015, 10219.233557483218, 10576.259661823753, 10714.571417143226, 10717.946410268054, 10747.0, 9950.55222514974, 10239.948800255952, 10546.103581195684, 10620.893791062144, 10764.13886889047, 7985.201479852085, 8130.878036829452, 8141.633626486822, 8188.918110819054, 8228.794280142925, 7924.801879953047, 7938.364930805637, 7983.720569780262, 8129.75610731679, 8155.510669359857, 9287.257019438564, 9509.19171870371, 9657.661981830603, 9733.270004749813, 9964.950175249078, 9699.6120155193, 9887.505624718879, 10063.798724025331, 10083.394996299952, 10164.33931794431, 6527.640979746159, 7131.82170445743, 7376.188619251985, 7380.704771809067, 7504.662290196845, 8120.269175774209, 8124.39067069984, 8157.877631835646, 8181.386396020203, 8195.508269503849, 6136.969315153396, 7169.605671687898, 7244.058272424551, 7401.888971665537, 7416.66625001887, 7131.108611423572, 7157.892631610634, 7196.604186769778, 7321.926780732338, 7325.560466372035, 7376.4467664926415, 7607.961960190164, 7615.200403957726, 7615.428842836699, 7618.314351708373, 6853.657317134223, 6938.548994315353, 6947.756828510978, 6963.1644202696, 6963.895541566779, 5809.186713859978, 6986.266442023514, 6988.336108069725, 7012.614306213003, 7035.155781306276], "unit": "score", "name": "mootools.html", "value": 4867.138502174245}, {"lowerIsBetter": false, "replicates": [315.03756025342574, 324.16527441837275, 327.1265720526195, 327.77056060757474, 331.4117441541264, 5921.822345329636, 6367.402417634039, 6541.705623246953, 6656.600603963766, 6671.899921501169, 6496.1554997850335, 6552.049952756847, 6563.507736919738, 6566.24488183859, 6573.539852210347, 4706.717596944177, 4801.44783349914, 4808.447028591704, 4872.780724867381, 4904.950950490503, 4901.754912254373, 4920.557149856512, 4937.0125974805005, 4945.085159245533, 4954.355933728628, 3944.0, 4858.125537403266, 4863.659543831933, 4880.048390563841, 4896.192128298826, 4671.953280467203, 4800.87997800056, 4822.54185852347, 4849.199882019498, 4853.587445067174, 4145.730527515701, 4147.04617937873, 4157.542670306264, 4160.334346504575, 4164.1879833432495, 6363.713632886531, 6447.709853056624, 6457.096006559085, 6464.676766161673, 6474.870502589922, 4478.865634030952, 5684.857878553028, 5720.685362305072, 5725.112607545837, 5731.856703582402, 5693.0, 5694.0, 7088.0, 7092.858142837114, 7095.858082838366, 4419.558044195587, 4568.0407114506, 4599.31010348447, 4600.217962946307, 4601.217792975169, 6502.187226596676, 7400.740974065882, 7486.887696684554, 7552.8867066994035, 7570.659320330598, 4017.5580686124504, 4510.075434535912, 4656.371389862393, 4660.161170989187, 4660.6970546914345, 4703.365045718852, 4706.1528924793865, 4715.3869996900185, 4716.504766999485, 4717.740524271198, 5622.425720798183, 5625.071863142617, 5626.943730562723, 5634.690092044977, 5635.21107045014, 6927.515073944775, 7144.749933752398, 7180.8922866157045, 7195.676194571257, 7197.748078817216, 1416.6954104867298, 1686.569924669226, 1718.4157386488655, 1720.1485264794007, 1722.7588137660737, 1039.142707266508, 1066.3335415365398, 1105.5190991918541, 1106.6443606581872, 1130.9934158598853, 5400.243965844785, 5616.775328986795, 6597.86804263912, 6728.360805723449, 6733.966330168416, 7490.026296581518, 7505.136909255396, 7507.1366792818435, 7512.774616761506, 7515.398768098539, 6687.6321802301345, 6704.318272690865, 6715.227748808949, 6718.428933540606, 6719.395254427125, 3830.4254361845947, 3931.5256778707985, 3971.3645816669195, 3971.702122340836, 3973.264945985002, 6407.103005579223, 7670.0, 7877.566733829694, 7879.881801772978, 7887.566183859828, 6377.394147555975, 6983.546069505466, 7609.896564998045, 7744.341730952932, 7748.65131069092, 7779.0, 7814.023247094114, 7820.687172513036, 7824.491408058458, 7826.7651970440975, 6051.818445446644, 7175.959485874623, 7485.663145158372, 7491.925080749123, 7499.512531685423, 7325.963370183115, 7359.264073592812, 7381.188069312479, 7430.44271679637, 7449.106107267163, 7860.213978602094, 7881.960590197013, 7883.763487095396, 7885.369170466463, 7906.248906353887, 4630.953690463052, 4686.226772582622, 4690.366800481891, 4693.718376897397, 4700.412448443944, 6381.968090159519, 6999.985002174758, 7123.358897699232, 7480.4763666544995, 7482.588457634883, 5804.303483581997, 6506.3493650634555, 6604.976228684562, 7175.2465991070185, 7241.4206863451855, 5842.737076831638, 7200.531965422231, 7221.45839062083, 7224.169220539705, 7228.530145540523, 7035.12060992376, 7040.260772618802, 7048.154221493453, 7054.153501579844, 7056.788296351117, 6957.617331046841, 7209.0628218331285, 7232.855342893218, 7243.348098671145, 7246.89129663045, 6770.966145169243, 6916.723331066701, 6917.066196063467, 6994.370506654425, 7096.680649370894], "unit": "score", "name": "prototype.html", "value": 5151.4081718800035}, {"lowerIsBetter": false, "replicates": [588.4821357205658, 630.6720505337223, 645.4416929356105, 655.672163918041, 711.9003339532463, 14764.409423623056, 14905.180215088192, 14929.5521134366, 14953.953223274375, 16707.415240466587, 15357.232138393092, 15405.0, 15431.768523472158, 15452.304646290915, 15457.381704731826, 706.261956255714, 865.9653613855438, 890.8841850559418, 893.227358335042, 893.8703887936246, 709.3013381818904, 709.9705427130656, 712.9037579926695, 713.1940906775336, 855.70050482331, 915.9587818548148, 918.347972939214, 919.4575200631626, 920.1258804136064, 920.6225447566499, 907.3965812734524, 913.8629205619144, 914.2229105260542, 914.9634014639406, 915.3546749541624, 547.5482726750407, 555.4417810100863, 556.0241775683689, 676.3540818518303, 680.4352387518348, 14769.33537990793, 14951.252437378087, 14954.327055282538, 14958.252087395695, 14969.176695281754, 12100.273983561014, 12158.0, 12170.513179472811, 12540.372981350987, 12575.308358040304, 9806.215502759762, 9963.103320701171, 9972.501374931297, 10232.386056836614, 10751.247412681116, 3473.1838018065732, 3476.5132881396626, 3505.088676944013, 3550.6483706336776, 3586.6413358664186, 87085.0, 87732.56133719355, 88569.78575535599, 89319.0, 89509.0, 9171.494381238226, 9315.254779617615, 9376.765580860396, 9381.577828997712, 9398.201152901944, 20792.37622871316, 20805.271815486387, 20814.895925520275, 20867.478313042295, 21170.682439763415, 7151.106111736033, 7182.066331376887, 7251.166115896739, 7267.273272672691, 7379.483436159418, 4003.11931375097, 4017.738846974937, 4053.8783836484954, 4060.9796951015055, 4104.281750693676, 3396.2698019925833, 3437.810920399402, 3438.277961628036, 3441.8107004115013, 3455.6198818129988, 582.118091091996, 582.6038293960063, 584.7631709157798, 591.5356445190505, 599.7451083289584, 578.9768409263582, 580.3326174898816, 613.4356392119261, 618.8762247550508, 625.4391433858789, 7837.1379148293645, 8037.316828069563, 8158.551279679675, 8300.294474969694, 8424.98900131988, 520.6901893373437, 572.4161355417451, 603.3694788945562, 609.774383478116, 614.5145335185243, 2984.5373967035143, 3792.5259342582176, 3796.4061747458873, 3796.9430458543143, 3846.4614953906475, 93649.5317523408, 93694.0, 94521.0, 94697.0, 94932.0, 80594.0, 80795.59602201951, 81615.59192204001, 82756.58621706853, 82805.17194828096, 69734.0, 70580.64709676521, 70634.2936570638, 70824.64587677029, 71262.64368678123, 7559.962200189184, 7588.62056897164, 7736.187700291388, 7738.574378409242, 7752.224777522202, 48181.27728084011, 49652.510424687316, 49830.0, 50229.497705022484, 50307.0, 56130.71934640464, 59210.70394647999, 63829.0, 69261.65369173122, 69574.65212673905, 9776.853347199656, 9793.657221997197, 9882.258830587878, 9930.453825039693, 10471.476426178508, 11932.403379830801, 12110.878891210976, 12174.634760957186, 12574.874251257736, 12703.809442858179, 11281.32312061279, 11287.604933827277, 11294.209405341548, 11408.657740267805, 11701.76596468083, 11446.427678616203, 11516.539338426704, 11525.942370288094, 11606.30362178272, 11705.531778728755, 11124.555017799197, 11152.498137583665, 11351.262167959056, 11424.371659558805, 12026.338551379758, 9380.390274632127, 9614.807703846023, 9628.0, 9659.372140810825, 9749.56126974302, 7768.495047821873, 9442.669506567237, 9633.614655413705, 9754.0, 9775.462349570558], "unit": "score", "name": "yui.html", "value": 6756.840986745397}], "name": "dromaeo_css", "value": 7440.80136160104}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 112.0, 108.0, 109.0, 110.0, 116.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [155.0, 121.0, 154.0, 156.0, 121.0, 142.0, 141.0, 112.0, 162.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 138.2}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 185.0, 184.0, 183.0, 182.0, 183.0, 185.0, 182.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.5}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 85.0, 76.0, 55.0, 58.0, 58.0, 78.0, 76.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.3}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 132.0, 79.0, 80.0, 87.0, 100.0, 75.0, 119.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 100.6}, {"lowerIsBetter": true, "replicates": [83.0, 90.0, 84.0, 91.0, 84.0, 89.0, 84.0, 90.0, 83.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 93.0, 94.0, 92.0, 94.0, 93.0, 92.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 93.3}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 88.0, 87.0, 85.0, 87.0, 104.0, 135.0, 144.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 98.8}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 55.0, 53.0, 54.0, 56.0, 54.0, 63.0, 59.0, 77.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [63.0, 67.0, 72.0, 73.0, 69.0, 67.0, 66.0, 66.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [98.0, 107.0, 94.0, 82.0, 82.0, 82.0, 82.0, 81.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [124.0, 122.0, 141.0, 131.0, 127.0, 113.0, 123.0, 121.0, 117.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [137.0, 137.0, 137.0, 134.0, 139.0, 125.0, 137.0, 139.0, 134.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 67.0, 65.0, 65.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1420.8}]} 14:37:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1420.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7440.80"}}} 14:37:09 INFO - Return code: 0 14:37:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:37:10 INFO - # TBPL SUCCESS # 14:37:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:37:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:37:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:37:10 INFO - 2016-02-25 14:37:10.019 screenresolution[1686:10012] starting screenresolution argv=screenresolution get 14:37:10 INFO - 2016-02-25 14:37:10.022 screenresolution[1686:10012] Display 0: 1600x1200x32@60 14:37:10 INFO - 2016-02-25 14:37:10.028 screenresolution[1687:10016] starting screenresolution argv=screenresolution list 14:37:10 INFO - Available Modes on Display 0 14:37:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:37:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:37:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:37:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:37:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:37:10 INFO - Intel Iris: 14:37:10 INFO - Chipset Model: Intel Iris 14:37:10 INFO - Type: GPU 14:37:10 INFO - Bus: Built-In 14:37:10 INFO - VRAM (Dynamic, Max): 1536 MB 14:37:10 INFO - Vendor: Intel (0x8086) 14:37:10 INFO - Device ID: 0x0a2e 14:37:10 INFO - Revision ID: 0x0009 14:37:10 INFO - Displays: 14:37:10 INFO - Display: 14:37:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:37:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:37:10 INFO - Display Serial Number: 1600x1200 60 14:37:10 INFO - Main Display: Yes 14:37:10 INFO - Mirror: Off 14:37:10 INFO - Online: Yes 14:37:10 INFO - Rotation: Supported 14:37:10 INFO - Return code: 0 14:37:10 INFO - Running post-action listener: _resource_record_post_action 14:37:10 INFO - Running post-run listener: _resource_record_post_run 14:37:11 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 39400960; Write bytes: 708308480; Read time: 420; Write time: 1982 14:37:11 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403933696; Write bytes: 395621888; Read time: 30065; Write time: 727 14:37:11 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 37586432; Write bytes: 301111296; Read time: 400; Write time: 1221 14:37:11 INFO - Running post-run listener: _upload_blobber_files 14:37:11 INFO - Blob upload gear active. 14:37:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:37:11 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 14:37:11 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'] 14:37:11 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 14:37:11 INFO - (blobuploader) - INFO - Open directory for files ... 14:37:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:37:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:37:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:12 INFO - (blobuploader) - INFO - Done attempting. 14:37:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:37:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:37:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:14 INFO - (blobuploader) - INFO - Done attempting. 14:37:14 INFO - (blobuploader) - INFO - Iteration through files over. 14:37:14 INFO - Return code: 0 14:37:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:37:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:37:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/607f0b3c92434a72c9be490ffaff006eec433e248af6d9c60a0a98eb0bf8759d680e5ac3c0b0ac4d15ab5853454876d2c62094e20880672f75c2d18b55bc6e51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7fc0bbea09d67a61605439d563027a5580b9738a85ece52557f9401b4efd850e8e77e25ff50cd4d964c2f79093c1f8a7b26e7cd6c7618e7f94da7c8cc2fa703"} 14:37:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:37:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:37:14 INFO - Contents: 14:37:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/607f0b3c92434a72c9be490ffaff006eec433e248af6d9c60a0a98eb0bf8759d680e5ac3c0b0ac4d15ab5853454876d2c62094e20880672f75c2d18b55bc6e51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7fc0bbea09d67a61605439d563027a5580b9738a85ece52557f9401b4efd850e8e77e25ff50cd4d964c2f79093c1f8a7b26e7cd6c7618e7f94da7c8cc2fa703"} 14:37:14 INFO - Running post-run listener: copy_logs_to_upload_dir 14:37:14 INFO - Copying logs to upload dir... 14:37:14 INFO - mkdir: /builds/slave/test/build/upload/logs 14:37:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.105821 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-25 14:37:14.492174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 14:37:14.499136) ========= 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.r7JnyNxF9i/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.GsASjBpe26/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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/607f0b3c92434a72c9be490ffaff006eec433e248af6d9c60a0a98eb0bf8759d680e5ac3c0b0ac4d15ab5853454876d2c62094e20880672f75c2d18b55bc6e51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7fc0bbea09d67a61605439d563027a5580b9738a85ece52557f9401b4efd850e8e77e25ff50cd4d964c2f79093c1f8a7b26e7cd6c7618e7f94da7c8cc2fa703"} build_url:https://queue.taskcluster.net/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/akEdc4p0RoK7D39vnUnxmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/607f0b3c92434a72c9be490ffaff006eec433e248af6d9c60a0a98eb0bf8759d680e5ac3c0b0ac4d15ab5853454876d2c62094e20880672f75c2d18b55bc6e51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7fc0bbea09d67a61605439d563027a5580b9738a85ece52557f9401b4efd850e8e77e25ff50cd4d964c2f79093c1f8a7b26e7cd6c7618e7f94da7c8cc2fa703"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 14:37:14.527569) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 14:37:14.527961) ========= 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.r7JnyNxF9i/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.GsASjBpe26/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005312 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 14:37:14.576647) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 14:37:14.577012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 14:37:14.577407) ========= ========= Total master_lag: 6.03 =========