builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0002 starttime: 1459835599.89 results: success (0) buildid: 20160404205708 builduid: d9ab8a4798d64a6786397273d9757864 revision: 7875a8acb8c47dbe656833e3493f7a5d5e5a480b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 22:53:19.886600) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 22:53:19.887068) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 22:53:19.887371) ========= 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.vfKkZZTipb/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.XZIlBypFyR/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005635 basedir: '/builds/slave/test' ========= master_lag: 0.69 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 22:53:20.582640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-04 22:53:20.586994) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-04 22:53:22.342357) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 22:53:22.342811) ========= 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.vfKkZZTipb/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.XZIlBypFyR/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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: 1.49 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 22:53:23.839067) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 22:53:23.839371) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 22:53:23.843757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-04-04 22:53:23.844045) ========= 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.vfKkZZTipb/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.XZIlBypFyR/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-04-04 22:53:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.70M=0.002s 2016-04-04 22:53:24 (6.70 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.644671 ========= master_lag: 9.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-04-04 22:53:33.720622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 22:53:33.720966) ========= 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.vfKkZZTipb/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.XZIlBypFyR/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.019795 ========= master_lag: 1.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 22:53:34.787301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-04 22:53:34.787652) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7875a8acb8c47dbe656833e3493f7a5d5e5a480b --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 7875a8acb8c47dbe656833e3493f7a5d5e5a480b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vfKkZZTipb/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.XZIlBypFyR/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-04-04 22:53:34,871 truncating revision to first 12 chars 2016-04-04 22:53:34,871 Setting DEBUG logging. 2016-04-04 22:53:34,872 attempt 1/10 2016-04-04 22:53:34,872 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7875a8acb8c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 22:53:36,189 unpacking tar archive at: fx-team-7875a8acb8c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.558865 ========= master_lag: 0.47 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-04 22:53:36.814491) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 22:53:36.814882) ========= echo 7875a8acb8c47dbe656833e3493f7a5d5e5a480b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7875a8acb8c47dbe656833e3493f7a5d5e5a480b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vfKkZZTipb/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.XZIlBypFyR/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 7875a8acb8c47dbe656833e3493f7a5d5e5a480b program finished with exit code 0 elapsedTime=0.004933 script_repo_revision: '7875a8acb8c47dbe656833e3493f7a5d5e5a480b' ========= master_lag: 0.03 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 22:53:36.853837) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 22:53:36.854143) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 22:53:36.879396) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-04 22:53:36.879675) ========= /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.vfKkZZTipb/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.XZIlBypFyR/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 22:53:37 INFO - MultiFileLogger online at 20160404 22:53:37 in /builds/slave/test 22:53:37 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 22:53:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:53:37 INFO - {'append_to_log': False, 22:53:37 INFO - 'base_work_dir': '/builds/slave/test', 22:53:37 INFO - 'blob_upload_branch': 'Fx-Team', 22:53:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:53:37 INFO - 'branch': 'Fx-Team', 22:53:37 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:37 INFO - 'config_files': ('talos/mac_config.py',), 22:53:37 INFO - 'default_actions': ('clobber', 22:53:37 INFO - 'read-buildbot-config', 22:53:37 INFO - 'download-and-extract', 22:53:37 INFO - 'populate-webroot', 22:53:37 INFO - 'create-virtualenv', 22:53:37 INFO - 'install', 22:53:37 INFO - 'run-tests'), 22:53:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:37 INFO - 'download_minidump_stackwalk': True, 22:53:37 INFO - 'download_symbols': 'ondemand', 22:53:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:37 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:37 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:37 INFO - 'installer_path': 'installer.exe', 22:53:37 INFO - 'log_level': 'info', 22:53:37 INFO - 'log_name': 'talos', 22:53:37 INFO - 'log_to_console': True, 22:53:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:53:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:53:37 INFO - 'opt_config_files': (), 22:53:37 INFO - 'pip_index': False, 22:53:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:53:37 INFO - 'cmd': ('bash', 22:53:37 INFO - '-c', 22:53:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:53:37 INFO - 'enabled': True, 22:53:37 INFO - 'halt_on_failure': False, 22:53:37 INFO - 'name': 'check_screen_resolution'},), 22:53:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:53:37 INFO - 'cmd': ('bash', 22:53:37 INFO - '-c', 22:53:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:53:37 INFO - 'enabled': True, 22:53:37 INFO - 'halt_on_failure': False, 22:53:37 INFO - 'name': 'check_screen_resolution'},), 22:53:37 INFO - 'run_cmd_checks_enabled': True, 22:53:37 INFO - 'sps_profile': False, 22:53:37 INFO - 'sps_profile_interval': 0, 22:53:37 INFO - 'suite': 'dromaeojs', 22:53:37 INFO - 'system_bits': '32', 22:53:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:37 INFO - 'title': 't-yosemite-r7-0002', 22:53:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:37 INFO - 'use_talos_json': True, 22:53:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:53:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:37 INFO - 'work_dir': 'build'} 22:53:37 INFO - ##### 22:53:37 INFO - ##### Running clobber step. 22:53:37 INFO - ##### 22:53:37 INFO - Running pre-action listener: _resource_record_pre_action 22:53:37 INFO - Running main action method: clobber 22:53:37 INFO - rmtree: /builds/slave/test/build 22:53:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:53:37 INFO - Running post-action listener: _resource_record_post_action 22:53:38 INFO - ##### 22:53:38 INFO - ##### Running read-buildbot-config step. 22:53:38 INFO - ##### 22:53:38 INFO - Running pre-action listener: _resource_record_pre_action 22:53:38 INFO - Running main action method: read_buildbot_config 22:53:38 INFO - Using buildbot properties: 22:53:38 INFO - { 22:53:38 INFO - "project": "", 22:53:38 INFO - "product": "firefox", 22:53:38 INFO - "script_repo_revision": "production", 22:53:38 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 22:53:38 INFO - "repository": "", 22:53:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 22:53:38 INFO - "buildid": "20160404205708", 22:53:38 INFO - "pgo_build": "False", 22:53:38 INFO - "basedir": "/builds/slave/test", 22:53:38 INFO - "buildnumber": 673, 22:53:38 INFO - "slavename": "t-yosemite-r7-0002", 22:53:38 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 22:53:38 INFO - "platform": "yosemite_r7", 22:53:38 INFO - "scheduler": "tests-fx-team-macosx64-talos", 22:53:38 INFO - "branch": "fx-team", 22:53:38 INFO - "repo_path": "integration/fx-team", 22:53:38 INFO - "revision": "7875a8acb8c47dbe656833e3493f7a5d5e5a480b", 22:53:38 INFO - "stage_platform": "macosx64", 22:53:38 INFO - "builduid": "d9ab8a4798d64a6786397273d9757864", 22:53:38 INFO - "slavebuilddir": "test" 22:53:38 INFO - } 22:53:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 22:53:38 INFO - Running post-action listener: _resource_record_post_action 22:53:38 INFO - ##### 22:53:38 INFO - ##### Running download-and-extract step. 22:53:38 INFO - ##### 22:53:38 INFO - Running pre-action listener: _resource_record_pre_action 22:53:38 INFO - Running main action method: download_and_extract 22:53:38 INFO - mkdir: /builds/slave/test/build/tests 22:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:38 INFO - https://queue.taskcluster.net/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 22:53:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:53:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:53:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 22:53:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 22:53:39 INFO - Downloaded 1199 bytes. 22:53:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 22:53:39 INFO - Using the following test package requirements: 22:53:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:53:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:53:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 22:53:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:53:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 22:53:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:53:39 INFO - u'jsshell-mac.zip'], 22:53:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:53:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 22:53:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:53:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:53:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 22:53:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:53:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 22:53:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:53:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 22:53:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:53:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 22:53:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:53:39 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')]} 22:53:39 INFO - https://queue.taskcluster.net/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:53:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:53:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:53:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:53:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:53:41 INFO - Downloaded 17959988 bytes. 22:53:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:53:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:53:44 INFO - Return code: 0 22:53:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:53:44 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')]} 22:53:44 INFO - https://queue.taskcluster.net/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:53:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:53:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:53:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:53:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:53:47 INFO - Downloaded 17959988 bytes. 22:53:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:53:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:53:50 INFO - Return code: 0 22:53: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')]} 22:53:50 INFO - https://queue.taskcluster.net/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:53:51 INFO - Downloaded 10847584 bytes. 22:53:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:53:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 22:53:52 INFO - Return code: 0 22:53:52 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')]} 22:53:52 INFO - https://queue.taskcluster.net/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:53:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:53:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:53:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 22:53:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 22:54:01 INFO - Downloaded 111342820 bytes. 22:54:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:54:01 INFO - mkdir: /builds/slave/test/properties 22:54:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:54:01 INFO - Writing to file /builds/slave/test/properties/build_url 22:54:01 INFO - Contents: 22:54:01 INFO - build_url:https://queue.taskcluster.net/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:54:02 INFO - Running post-action listener: _resource_record_post_action 22:54:02 INFO - Running post-action listener: set_extra_try_arguments 22:54:02 INFO - ##### 22:54:02 INFO - ##### Running populate-webroot step. 22:54:02 INFO - ##### 22:54:02 INFO - Running pre-action listener: _resource_record_pre_action 22:54:02 INFO - Running main action method: populate_webroot 22:54:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:54:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:54:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:54:02 INFO - '--tppagecycles', 22:54:02 INFO - '7'], 22:54:02 INFO - 'tests': ['tsvgm']}}, 22:54:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:54:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:54:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:54:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:54:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:54:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:54:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:02 INFO - 'talos_options': ['--e10s'], 22:54:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:02 INFO - 'tests': ['damp', 'tps']}, 22:54:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:02 INFO - 'talos_options': ['--e10s'], 22:54:02 INFO - 'tests': ['damp', 'tps']}, 22:54:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:54:02 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 22:54:02 INFO - 'tests': ['dromaeo_dom']}, 22:54:02 INFO - 'other': {'tests': ['a11yr', 22:54:02 INFO - 'ts_paint', 22:54:02 INFO - 'tpaint', 22:54:02 INFO - 'sessionrestore', 22:54:02 INFO - 'sessionrestore_no_auto_restore', 22:54:02 INFO - 'tabpaint']}, 22:54:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:54:02 INFO - 'tests': ['a11yr', 22:54:02 INFO - 'ts_paint', 22:54:02 INFO - 'tpaint', 22:54:02 INFO - 'sessionrestore', 22:54:02 INFO - 'sessionrestore_no_auto_restore', 22:54:02 INFO - 'tabpaint']}, 22:54:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:54:02 INFO - 'tests': ['a11yr', 22:54:02 INFO - 'ts_paint', 22:54:02 INFO - 'tpaint', 22:54:02 INFO - 'sessionrestore', 22:54:02 INFO - 'sessionrestore_no_auto_restore', 22:54:02 INFO - 'tabpaint']}, 22:54:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:54:02 INFO - 'tests': ['a11yr', 22:54:02 INFO - 'ts_paint', 22:54:02 INFO - 'tpaint', 22:54:02 INFO - 'sessionrestore', 22:54:02 INFO - 'sessionrestore_no_auto_restore', 22:54:02 INFO - 'tabpaint']}, 22:54:02 INFO - 'other_l64': {'tests': ['a11yr', 22:54:02 INFO - 'ts_paint', 22:54:02 INFO - 'tpaint', 22:54:02 INFO - 'sessionrestore', 22:54:02 INFO - 'sessionrestore_no_auto_restore', 22:54:02 INFO - 'tabpaint']}, 22:54:02 INFO - 'other_nol64': {'tests': ['a11yr', 22:54:02 INFO - 'ts_paint', 22:54:02 INFO - 'tpaint', 22:54:02 INFO - 'sessionrestore', 22:54:02 INFO - 'sessionrestore_no_auto_restore', 22:54:02 INFO - 'tabpaint']}, 22:54:02 INFO - 'svgr': {'tests': ['tsvgx', 22:54:02 INFO - 'tsvgr_opacity', 22:54:02 INFO - 'tart', 22:54:02 INFO - 'tscrollx', 22:54:02 INFO - 'cart']}, 22:54:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:54:02 INFO - 'tests': ['tsvgx', 22:54:02 INFO - 'tsvgr_opacity', 22:54:02 INFO - 'tart', 22:54:02 INFO - 'tscrollx', 22:54:02 INFO - 'cart']}, 22:54:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:02 INFO - 'tests': ['tp5o']}, 22:54:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:02 INFO - 'talos_options': ['--e10s'], 22:54:02 INFO - 'tests': ['tp5o']}, 22:54:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:02 INFO - 'talos_options': ['--xperf_path', 22:54:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:02 INFO - 'tests': ['tp5n']}, 22:54:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:02 INFO - 'talos_options': ['--e10s', 22:54:02 INFO - '--xperf_path', 22:54:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:02 INFO - 'tests': ['tp5n']}}, 22:54:02 INFO - 'talos.zip': {'path': '', 22:54:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:54:02 INFO - Running post-action listener: _resource_record_post_action 22:54:02 INFO - ##### 22:54:02 INFO - ##### Running create-virtualenv step. 22:54:02 INFO - ##### 22:54:02 INFO - Running pre-action listener: _resource_record_pre_action 22:54:02 INFO - Running main action method: create_virtualenv 22:54:02 INFO - Creating virtualenv /builds/slave/test/build/venv 22:54:02 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 22:54:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:54:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:54:02 INFO - Using real prefix '/tools/python27' 22:54:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:54:03 INFO - Installing distribute.............................................................................................................................................................................................done. 22:54:06 INFO - Installing pip.................done. 22:54:06 INFO - Return code: 0 22:54:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:06 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 0x100899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008a9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4bc7e380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100738e00>, '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 0x100561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100733b20>, '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.vfKkZZTipb/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.XZIlBypFyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 22:54:06 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 22:54:06 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 22:54:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vfKkZZTipb/Render', 22:54:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:54:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:54:06 INFO - 'HOME': '/Users/cltbld', 22:54:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:54:06 INFO - 'LOGNAME': 'cltbld', 22:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:06 INFO - 'MOZ_NO_REMOTE': '1', 22:54:06 INFO - 'NO_EM_RESTART': '1', 22:54:06 INFO - 'PAGER': '/bin/cat', 22:54:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:06 INFO - 'PWD': '/builds/slave/test', 22:54:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:54:06 INFO - 'SHELL': '/bin/bash', 22:54:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZIlBypFyR/Listeners', 22:54:06 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 22:54:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:54:06 INFO - 'USER': 'cltbld', 22:54:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:54:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:06 INFO - 'XPC_FLAGS': '0x0', 22:54:06 INFO - 'XPC_SERVICE_NAME': '0', 22:54:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:06 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 22:54:06 INFO - Cleaning up... 22:54:06 INFO - Return code: 0 22:54:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:06 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 0x100899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008a9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4bc7e380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100738e00>, '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 0x100561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100733b20>, '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.vfKkZZTipb/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.XZIlBypFyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 22:54:06 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 22:54:06 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 22:54:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vfKkZZTipb/Render', 22:54:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:54:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:54:06 INFO - 'HOME': '/Users/cltbld', 22:54:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:54:06 INFO - 'LOGNAME': 'cltbld', 22:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:06 INFO - 'MOZ_NO_REMOTE': '1', 22:54:06 INFO - 'NO_EM_RESTART': '1', 22:54:06 INFO - 'PAGER': '/bin/cat', 22:54:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:06 INFO - 'PWD': '/builds/slave/test', 22:54:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:54:06 INFO - 'SHELL': '/bin/bash', 22:54:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZIlBypFyR/Listeners', 22:54:06 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 22:54:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:54:06 INFO - 'USER': 'cltbld', 22:54:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:54:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:06 INFO - 'XPC_FLAGS': '0x0', 22:54:06 INFO - 'XPC_SERVICE_NAME': '0', 22:54:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:06 INFO - Downloading/unpacking psutil>=0.7.1 22:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:54:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:10 INFO - Installing collected packages: psutil 22:54:10 INFO - Running setup.py install for psutil 22:54:10 INFO - building 'psutil._psutil_osx' extension 22:54:10 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 22:54:10 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 22:54:10 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 22:54:11 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 22:54:11 INFO - building 'psutil._psutil_posix' extension 22:54:11 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 22:54:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:54:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:54:11 INFO - ^ 22:54:11 INFO - 1 warning generated. 22:54:11 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 22:54:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:11 INFO - Successfully installed psutil 22:54:11 INFO - Cleaning up... 22:54:11 INFO - Return code: 0 22:54:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:11 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 0x100899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008a9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4bc7e380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100738e00>, '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 0x100561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100733b20>, '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.vfKkZZTipb/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.XZIlBypFyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 22:54:11 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 22:54:11 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 22:54:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vfKkZZTipb/Render', 22:54:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:54:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:54:11 INFO - 'HOME': '/Users/cltbld', 22:54:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:54:11 INFO - 'LOGNAME': 'cltbld', 22:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:11 INFO - 'MOZ_NO_REMOTE': '1', 22:54:11 INFO - 'NO_EM_RESTART': '1', 22:54:11 INFO - 'PAGER': '/bin/cat', 22:54:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:11 INFO - 'PWD': '/builds/slave/test', 22:54:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:54:11 INFO - 'SHELL': '/bin/bash', 22:54:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZIlBypFyR/Listeners', 22:54:11 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 22:54:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:54:11 INFO - 'USER': 'cltbld', 22:54:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:54:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:11 INFO - 'XPC_FLAGS': '0x0', 22:54:11 INFO - 'XPC_SERVICE_NAME': '0', 22:54:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 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 22:54:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:54:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:54:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:54:14 INFO - Installing collected packages: mozsystemmonitor 22:54:14 INFO - Running setup.py install for mozsystemmonitor 22:54:14 INFO - Successfully installed mozsystemmonitor 22:54:14 INFO - Cleaning up... 22:54:14 INFO - Return code: 0 22:54:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:14 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 0x100899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008a9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4bc7e380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100738e00>, '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 0x100561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100733b20>, '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.vfKkZZTipb/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.XZIlBypFyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 22:54:14 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 22:54:14 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 22:54:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vfKkZZTipb/Render', 22:54:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:54:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:54:14 INFO - 'HOME': '/Users/cltbld', 22:54:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:54:14 INFO - 'LOGNAME': 'cltbld', 22:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:14 INFO - 'MOZ_NO_REMOTE': '1', 22:54:14 INFO - 'NO_EM_RESTART': '1', 22:54:14 INFO - 'PAGER': '/bin/cat', 22:54:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:14 INFO - 'PWD': '/builds/slave/test', 22:54:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:54:14 INFO - 'SHELL': '/bin/bash', 22:54:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZIlBypFyR/Listeners', 22:54:14 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 22:54:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:54:14 INFO - 'USER': 'cltbld', 22:54:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:54:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:14 INFO - 'XPC_FLAGS': '0x0', 22:54:14 INFO - 'XPC_SERVICE_NAME': '0', 22:54:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:15 INFO - Downloading/unpacking blobuploader==1.2.4 22:54:15 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 22:54:15 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 22:54:15 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 22:54:15 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 22:54:15 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 22:54:15 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 22:54:17 INFO - Downloading blobuploader-1.2.4.tar.gz 22:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:54:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:54:17 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 22:54:17 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 22:54:17 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 22:54:17 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 22:54:17 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 22:54:17 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 22:54:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:54:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:18 INFO - Downloading docopt-0.6.1.tar.gz 22:54:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:54:18 INFO - Installing collected packages: blobuploader, requests, docopt 22:54:18 INFO - Running setup.py install for blobuploader 22:54:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:54:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:54:18 INFO - Running setup.py install for requests 22:54:19 INFO - Running setup.py install for docopt 22:54:19 INFO - Successfully installed blobuploader requests docopt 22:54:19 INFO - Cleaning up... 22:54:19 INFO - Return code: 0 22:54:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:19 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 0x100899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008a9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4bc7e380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100738e00>, '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 0x100561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100733b20>, '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.vfKkZZTipb/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.XZIlBypFyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 22:54:19 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 22:54:19 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 22:54:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vfKkZZTipb/Render', 22:54:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:54:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:54:19 INFO - 'HOME': '/Users/cltbld', 22:54:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:54:19 INFO - 'LOGNAME': 'cltbld', 22:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:19 INFO - 'MOZ_NO_REMOTE': '1', 22:54:19 INFO - 'NO_EM_RESTART': '1', 22:54:19 INFO - 'PAGER': '/bin/cat', 22:54:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:19 INFO - 'PWD': '/builds/slave/test', 22:54:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:54:19 INFO - 'SHELL': '/bin/bash', 22:54:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZIlBypFyR/Listeners', 22:54:19 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 22:54:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:54:19 INFO - 'USER': 'cltbld', 22:54:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:54:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:19 INFO - 'XPC_FLAGS': '0x0', 22:54:19 INFO - 'XPC_SERVICE_NAME': '0', 22:54:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:54:19 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ngQykn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:54:20 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-LpAlcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:54:20 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ReDG8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:54:20 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-q0ypaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:54:20 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-wCeLTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:54:20 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-WUpMMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:54:20 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-W82GNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:54:20 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-i3eCHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:54:20 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Oh_b35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:54:20 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-wGbh4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:54:20 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vl5aEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:54:21 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-OouW2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:54:21 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-PwuNX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:54:21 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-SAGxX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:21 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-dfFKjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:54:21 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-5x1wj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:54:21 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UMjFhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:54:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:54:21 INFO - Running setup.py install for manifestparser 22:54:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:54:21 INFO - Running setup.py install for mozcrash 22:54:21 INFO - Running setup.py install for mozdebug 22:54:22 INFO - Running setup.py install for mozdevice 22:54:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:54:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:54:22 INFO - Running setup.py install for mozfile 22:54:22 INFO - Running setup.py install for mozhttpd 22:54:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:54:22 INFO - Running setup.py install for mozinfo 22:54:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:54:22 INFO - Running setup.py install for mozInstall 22:54:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:54:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:54:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:54:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:54:22 INFO - Running setup.py install for mozleak 22:54:23 INFO - Running setup.py install for mozlog 22:54:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Running setup.py install for moznetwork 22:54:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Running setup.py install for mozprocess 22:54:23 INFO - Running setup.py install for mozprofile 22:54:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Running setup.py install for mozrunner 22:54:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Running setup.py install for mozscreenshot 22:54:23 INFO - Running setup.py install for moztest 22:54:24 INFO - Running setup.py install for mozversion 22:54:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:54:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:54:24 INFO - Cleaning up... 22:54:24 INFO - Return code: 0 22:54:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:24 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 0x100899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008a9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4bc7e380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100738e00>, '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 0x100561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100733b20>, '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.vfKkZZTipb/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.XZIlBypFyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 22:54:24 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 22:54:24 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 22:54:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vfKkZZTipb/Render', 22:54:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:54:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:54:24 INFO - 'HOME': '/Users/cltbld', 22:54:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:54:24 INFO - 'LOGNAME': 'cltbld', 22:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:24 INFO - 'MOZ_NO_REMOTE': '1', 22:54:24 INFO - 'NO_EM_RESTART': '1', 22:54:24 INFO - 'PAGER': '/bin/cat', 22:54:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:24 INFO - 'PWD': '/builds/slave/test', 22:54:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:54:24 INFO - 'SHELL': '/bin/bash', 22:54:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZIlBypFyR/Listeners', 22:54:24 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 22:54:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:54:24 INFO - 'USER': 'cltbld', 22:54:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:54:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:24 INFO - 'XPC_FLAGS': '0x0', 22:54:24 INFO - 'XPC_SERVICE_NAME': '0', 22:54:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:54:24 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-gCLumK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:54:24 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)) 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:54:24 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-zethWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:54:24 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-dcjeNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:54:24 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)) 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:54:24 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Vfjw6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:54:24 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)) 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:54:24 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-H0lklG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:54:25 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-5QDKIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:54:25 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Mi1EfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:54:25 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-_8islv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:54:25 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-3Bp2mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:54:25 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-fCq1bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:54:25 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-AyjIxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:54:25 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-A__2Bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:54:25 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-OwNaLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:54:25 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-oKOrIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:25 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UZEt_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:26 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)) 22:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:54:26 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-EKIia9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:54:26 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)) 22:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:54:26 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-smdC7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:54:26 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)) 22:54:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:54:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:54:26 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)) 22:54:26 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)) 22:54:26 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)) 22:54:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:28 INFO - Downloading blessings-1.6.tar.gz 22:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:54:29 INFO - Installing collected packages: blessings 22:54:29 INFO - Running setup.py install for blessings 22:54:29 INFO - Successfully installed blessings 22:54:29 INFO - Cleaning up... 22:54:29 INFO - Return code: 0 22:54:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:54:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:54:29 INFO - Reading from file tmpfile_stdout 22:54:29 INFO - Current package versions: 22:54:29 INFO - blessings == 1.6 22:54:29 INFO - blobuploader == 1.2.4 22:54:29 INFO - docopt == 0.6.1 22:54:29 INFO - manifestparser == 1.1 22:54:29 INFO - mozInstall == 1.12 22:54:29 INFO - mozcrash == 0.17 22:54:29 INFO - mozdebug == 0.1 22:54:29 INFO - mozdevice == 0.48 22:54:29 INFO - mozfile == 1.2 22:54:29 INFO - mozhttpd == 0.7 22:54:29 INFO - mozinfo == 0.9 22:54:29 INFO - mozleak == 0.1 22:54:29 INFO - mozlog == 3.1 22:54:29 INFO - moznetwork == 0.27 22:54:29 INFO - mozprocess == 0.22 22:54:29 INFO - mozprofile == 0.28 22:54:29 INFO - mozrunner == 6.11 22:54:29 INFO - mozscreenshot == 0.1 22:54:29 INFO - mozsystemmonitor == 0.0 22:54:29 INFO - moztest == 0.7 22:54:29 INFO - mozversion == 1.4 22:54:29 INFO - psutil == 3.1.1 22:54:29 INFO - requests == 1.2.3 22:54:29 INFO - wsgiref == 0.1.2 22:54:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:29 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 0x100899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008a9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4bc7e380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100738e00>, '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 0x100561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100733b20>, '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.vfKkZZTipb/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.XZIlBypFyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 22:54:29 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 22:54:29 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 22:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vfKkZZTipb/Render', 22:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:54:29 INFO - 'HOME': '/Users/cltbld', 22:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:54:29 INFO - 'LOGNAME': 'cltbld', 22:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:29 INFO - 'MOZ_NO_REMOTE': '1', 22:54:29 INFO - 'NO_EM_RESTART': '1', 22:54:29 INFO - 'PAGER': '/bin/cat', 22:54:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:29 INFO - 'PWD': '/builds/slave/test', 22:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:54:29 INFO - 'SHELL': '/bin/bash', 22:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZIlBypFyR/Listeners', 22:54:29 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 22:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:54:29 INFO - 'USER': 'cltbld', 22:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:29 INFO - 'XPC_FLAGS': '0x0', 22:54:29 INFO - 'XPC_SERVICE_NAME': '0', 22:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 INFO - Cleaning up... 22:54:29 INFO - Return code: 0 22:54:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008a9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4bc7e380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100738e00>, '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 0x100561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100733b20>, '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.vfKkZZTipb/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.XZIlBypFyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 22:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vfKkZZTipb/Render', 22:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:54:29 INFO - 'HOME': '/Users/cltbld', 22:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:54:29 INFO - 'LOGNAME': 'cltbld', 22:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:29 INFO - 'MOZ_NO_REMOTE': '1', 22:54:29 INFO - 'NO_EM_RESTART': '1', 22:54:29 INFO - 'PAGER': '/bin/cat', 22:54:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:29 INFO - 'PWD': '/builds/slave/test', 22:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:54:29 INFO - 'SHELL': '/bin/bash', 22:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZIlBypFyR/Listeners', 22:54:29 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 22:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:54:29 INFO - 'USER': 'cltbld', 22:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:29 INFO - 'XPC_FLAGS': '0x0', 22:54:29 INFO - 'XPC_SERVICE_NAME': '0', 22:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:30 INFO - Downloading/unpacking jsonschema 22:54:30 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 22:54:30 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 22:54:30 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 22:54:30 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 22:54:30 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 22:54:30 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 22:54:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:54:33 INFO - Downloading/unpacking functools32 (from jsonschema) 22:54:33 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 22:54:33 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 22:54:33 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 22:54:33 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 22:54:33 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 22:54:33 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 22:54:34 INFO - Downloading functools32-3.2.3-2.tar.gz 22:54:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:54:34 INFO - warning: no files found matching '*.txt' 22:54:34 INFO - no previously-included directories found matching 'build' 22:54:34 INFO - no previously-included directories found matching 'dist' 22:54:34 INFO - no previously-included directories found matching '.git*' 22:54:34 INFO - Installing collected packages: jsonschema, functools32 22:54:34 INFO - Running setup.py install for functools32 22:54:34 INFO - warning: no files found matching '*.txt' 22:54:34 INFO - no previously-included directories found matching 'build' 22:54:34 INFO - no previously-included directories found matching 'dist' 22:54:34 INFO - no previously-included directories found matching '.git*' 22:54:34 INFO - Successfully installed jsonschema functools32 22:54:34 INFO - Cleaning up... 22:54:34 INFO - Return code: 0 22:54:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:34 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 0x100899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008a9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4bc7e380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100738e00>, '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 0x100561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100733b20>, '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.vfKkZZTipb/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.XZIlBypFyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 22:54:34 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 22:54:34 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 22:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vfKkZZTipb/Render', 22:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:54:34 INFO - 'HOME': '/Users/cltbld', 22:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:54:34 INFO - 'LOGNAME': 'cltbld', 22:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:34 INFO - 'MOZ_NO_REMOTE': '1', 22:54:34 INFO - 'NO_EM_RESTART': '1', 22:54:34 INFO - 'PAGER': '/bin/cat', 22:54:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:34 INFO - 'PWD': '/builds/slave/test', 22:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:54:34 INFO - 'SHELL': '/bin/bash', 22:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZIlBypFyR/Listeners', 22:54:34 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 22:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:54:34 INFO - 'USER': 'cltbld', 22:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:34 INFO - 'XPC_FLAGS': '0x0', 22:54:34 INFO - 'XPC_SERVICE_NAME': '0', 22:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:34 INFO - Downloading/unpacking flake8 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:54:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:54:37 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 22:54:37 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 22:54:37 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 22:54:37 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 22:54:37 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 22:54:37 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 22:54:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:54:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:54:37 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 22:54:37 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 22:54:37 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 22:54:37 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 22:54:37 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 22:54:37 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 22:54:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:54:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:38 INFO - no previously-included directories found matching 'docs/_build' 22:54:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:54:38 INFO - Running setup.py install for pep8 22:54:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:38 INFO - no previously-included directories found matching 'docs/_build' 22:54:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:54:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:54:38 INFO - Cleaning up... 22:54:39 INFO - Return code: 0 22:54:39 INFO - Running post-action listener: _resource_record_post_action 22:54:39 INFO - Running post-action listener: _start_resource_monitoring 22:54:39 INFO - Starting resource monitoring. 22:54:39 INFO - ##### 22:54:39 INFO - ##### Running install step. 22:54:39 INFO - ##### 22:54:39 INFO - Running pre-action listener: _resource_record_pre_action 22:54:39 INFO - Running main action method: install 22:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:54:39 INFO - Reading from file tmpfile_stdout 22:54:39 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:54:39 INFO - Reading from file tmpfile_stdout 22:54:39 INFO - Output received: 22:54:39 INFO - Usage: mozinstall [options] installer 22:54:39 INFO - Options: 22:54:39 INFO - -h, --help show this help message and exit 22:54:39 INFO - -d DEST, --destination=DEST 22:54:39 INFO - Directory to install application into. [default: 22:54:39 INFO - "/builds/slave/test"] 22:54:39 INFO - --app=APP Application being installed. [default: firefox] 22:54:39 INFO - mkdir: /builds/slave/test/build/application 22:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:55:13 INFO - Reading from file tmpfile_stdout 22:55:13 INFO - Output received: 22:55:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:55:13 INFO - Running post-action listener: _resource_record_post_action 22:55:13 INFO - ##### 22:55:13 INFO - ##### Running run-tests step. 22:55:13 INFO - ##### 22:55:13 INFO - Running pre-action listener: _resource_record_pre_action 22:55:13 INFO - Running main action method: run_tests 22:55:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:55:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:55:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:55:13 INFO - 2016-04-04 22:55:13.086 screenresolution[1937:12300] starting screenresolution argv=screenresolution get 22:55:13 INFO - 2016-04-04 22:55:13.089 screenresolution[1937:12300] Display 0: 1600x1200x32@60 22:55:13 INFO - 2016-04-04 22:55:13.095 screenresolution[1938:12302] starting screenresolution argv=screenresolution list 22:55:13 INFO - Available Modes on Display 0 22:55:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:55:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:55:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:55:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:55:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:55:13 INFO - Intel Iris: 22:55:13 INFO - Chipset Model: Intel Iris 22:55:13 INFO - Type: GPU 22:55:13 INFO - Bus: Built-In 22:55:13 INFO - VRAM (Dynamic, Max): 1536 MB 22:55:13 INFO - Vendor: Intel (0x8086) 22:55:13 INFO - Device ID: 0x0a2e 22:55:13 INFO - Revision ID: 0x0009 22:55:13 INFO - Displays: 22:55:13 INFO - Display: 22:55:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:55:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:55:13 INFO - Display Serial Number: 1600x1200 60 22:55:13 INFO - Main Display: Yes 22:55:13 INFO - Mirror: Off 22:55:13 INFO - Online: Yes 22:55:13 INFO - Rotation: Supported 22:55:13 INFO - Return code: 0 22:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:55:13 INFO - Python 2.7.3 22:55:13 INFO - Return code: 0 22:55:13 INFO - grabbing minidump binary from tooltool 22:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:13 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 0x100738e00>, '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 0x100561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100733b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:55:13 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 22:55:13 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 22:55:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:55:13 INFO - Return code: 0 22:55:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:55:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:55:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:55:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:55:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:55:14 INFO - Return code: 0 22:55:14 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/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 22:55:14 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/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --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 22:55:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vfKkZZTipb/Render', 22:55:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:55:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:55:14 INFO - 'HOME': '/Users/cltbld', 22:55:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:55:14 INFO - 'LOGNAME': 'cltbld', 22:55:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:55:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:14 INFO - 'MOZ_NO_REMOTE': '1', 22:55:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:55:14 INFO - 'NO_EM_RESTART': '1', 22:55:14 INFO - 'PAGER': '/bin/cat', 22:55:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:14 INFO - 'PWD': '/builds/slave/test', 22:55:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:55:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:55:14 INFO - 'SHELL': '/bin/bash', 22:55:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZIlBypFyR/Listeners', 22:55:14 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 22:55:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:55:14 INFO - 'USER': 'cltbld', 22:55:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:55:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:14 INFO - 'XPC_FLAGS': '0x0', 22:55:14 INFO - 'XPC_SERVICE_NAME': '0', 22:55:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:55:14 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/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 22:55:14 INFO - mozversion application_buildid: 20160404205708 22:55:14 INFO - mozversion application_changeset: 7875a8acb8c47dbe656833e3493f7a5d5e5a480b 22:55:14 INFO - mozversion application_display_name: Nightly 22:55:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:55:14 INFO - mozversion application_name: Firefox 22:55:14 INFO - mozversion application_remotingname: firefox 22:55:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:55:14 INFO - mozversion application_vendor: Mozilla 22:55:14 INFO - mozversion application_version: 48.0a1 22:55:14 INFO - mozversion platform_buildid: 20160404205708 22:55:14 INFO - mozversion platform_changeset: 7875a8acb8c47dbe656833e3493f7a5d5e5a480b 22:55:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:55:14 INFO - mozversion platform_version: 48.0a1 22:55:14 INFO - using testdate: 1459835714 22:55:14 INFO - actual date: 1459835714 22:55:14 INFO - starting webserver on 'localhost:51894' 22:55:14 INFO - SUITE-START | Running 2 tests 22:55:14 INFO - TEST-START | dromaeo_css 22:55:14 INFO - operating with platform_type : mac_ 22:55:14 INFO - Initialising browser for dromaeo_css test... 22:55:14 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp5tFJnx/profile http://localhost:51894/getInfo.html) 22:55:17 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 22:55:17 INFO - PROCESS | 1956 | colorDepth:24 22:55:17 INFO - PROCESS | 1956 | Browser inner width/height: 1024/689 22:55:17 INFO - PROCESS | 1956 | __metrics 22:55:17 INFO - PROCESS | 1956 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:55:17 ERROR - PROCESS | 1956 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:55:17 INFO - TEST-INFO | 1956: exit 0 22:55:17 INFO - Browser initialized. 22:55:17 INFO - Running cycle 1/1 for dromaeo_css test... 22:55:17 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp5tFJnx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:55:29 INFO - PROCESS | 1958 | RSS: Main: 236154880 22:55:29 INFO - PROCESS | 1958 | 22:56:21 INFO - PROCESS | 1958 | 1459835781504 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] 22:58:31 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:51894/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51894/tests/dromaeo/cssquery-ext.html) 22:58:32 INFO - PROCESS | 1958 | RSS: Main: 341426176 22:58:32 INFO - PROCESS | 1958 | 23:01:34 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:51894/tests/dromaeo/cssquery-ext.html (next: http://localhost:51894/tests/dromaeo/cssquery-jquery.html) 23:01:35 INFO - PROCESS | 1958 | RSS: Main: 355807232 23:01:35 INFO - PROCESS | 1958 | 23:04:37 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:51894/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51894/tests/dromaeo/cssquery-mootools.html) 23:04:37 INFO - PROCESS | 1958 | RSS: Main: 364580864 23:04:37 INFO - PROCESS | 1958 | 23:07:39 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:51894/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51894/tests/dromaeo/cssquery-prototype.html) 23:07:40 INFO - PROCESS | 1958 | RSS: Main: 323616768 23:07:40 INFO - PROCESS | 1958 | 23:10:43 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:51894/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51894/tests/dromaeo/cssquery-yui.html) 23:10:44 INFO - PROCESS | 1958 | RSS: Main: 323084288 23:10:44 INFO - PROCESS | 1958 | 23:13:46 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:51894/tests/dromaeo/cssquery-yui.html (next: http://localhost:51894/tests/dromaeo/cssquery-dojo.html) 23:13:46 INFO - PROCESS | 1958 | RSS: Main: 389591040 23:13:46 INFO - PROCESS | 1958 | 23:13:46 INFO - PROCESS | 1958 | __start_tp_report 23:13:46 INFO - PROCESS | 1958 | _x_x_mozilla_page_load 23:13:46 INFO - PROCESS | 1958 | _x_x_mozilla_page_load_details 23:13:46 INFO - PROCESS | 1958 | |i|pagename|runs| 23:13:46 INFO - PROCESS | 1958 | |0;dojo.html;2970.9851450742744;3360.092774950763;3411.3006833599097;3456.9308613827716;3464.566929133858;5564.387917329091;5618;5643.2099506069135;5652.604317697757;5657.773689052438;4927.408710954682;5641.8589535261635;5660.745266463009;5674.631148975324;5686.63036902601;5060.620453465986;5067.5185857343495;5102.795888164469;5119.744012799364;5281.656692314988;5198.584113270948;5231.084560201968;5242.449542797989;5261.447548007462;5311.840644780663;5032.245163225509;5115.974420127913;5122.641415100945;5125.359330083739;5194.506521880416;5075.720835354054;5091.159958606825;5093.694378337312;5095.617828662828;5195.896082078338;5123.8206662767;5138.897222055575;5139.254808052849;5173.379194496647;5224.947750522484;5594.4964953154;5608.635438696512;5618.213450116987;5618.410066942953;5664.150377443375;6093.542984276152;6105.542084343648;6213.627182369072;6213.689315534205;6223.408776166257;4913.606911447076;6267.843303917393;6281.842953926189;6284.151639528696;6308.337624549402;5685.403032681592;5761.48146666802;5772.422757724236;5783.363829978741;5783.624064435799;6161.199044124325;6213.65824879636;6217.347178546278;6273.874522509615;6278.529110316653;6064.616930969446;6069.848253793602;6101.694915254219;6105.763021687103;6136.570440069152;6177.163726227764;6226.813195604139;6240.500759939194;6244.12582238487;6245.406686364788;6038.30559485656;6083.087536869417;6095.982463883823;6114.114890844268;6175.166352542439;6133.44798968095;6145.371476558716;6168.0439531872635;6176.444120029129;6188.381161883775;4839.443464001614;4852;4857.562819346205;4860.902781944341;4903.754812259373;4292.098659281586;4339.5660433956355;4375.606195442426;4390.868273951786;4454.242778727624;5674.4892959633835;5685.516731077904;5689.231953686282;5690.374058853523;5690.971545142331;5155.948440515622;6206.162168107247;6261.812145635638;6270.31026587075;6273.278572964167;5549.389567147691;5628;5643.463870932255;5655.123455864347;5718.771249150071;5291.788328466818;5298.629095963245;5307.734613269321;5313.628046036741;5337.786488540492;5251.238570407269;6029.517638588903;6274.152989346379;6287.339829317947;6292.685365731787;5906.793262235973;6122.540809439399;6151.661658608819;6208;6232.376762323732;6199.597026193283;6272.498200143887;6273.215848018997;6283.308836027942;6284.937150628435;6115.938840611715;6119.388061193845;6127.877442451215;6139.693015349304;6174.629522228681;6131.724072416841;6174.845628859314;6208.875822483435;6229.750809967551;6248.062790581449;6049.758009679739;6076.997295446378;6089.786857459968;6099.748120842393;6143.201383820075;6019.488343490677;6045.879082418415;6054.061620448838;6065.909011364744;6088.847778805565;5800.854978625568;5895.734691938787;5957.76168953237;5963.4334738199805;6013.278406591062;6059.545534085049;6070.119832624333;6076.179715738495;6080.270367555921;6093.36019717941;5799.4780469757925;5930.970345148246;5937.287525496968;5949;5951.791687290924 23:13:46 INFO - PROCESS | 1958 | |1;ext.html;460.83870645274135;578.6065475476677;590.9172715819786;620.1503939602743;637.047613817343;29982;38779.806100969494;39106.8044659777;39139.02152446187;39205;42015;42606.57393426065;42687.57312426875;42701.57298427015;42728;9523.57143928525;9755.122039016487;9758.609655613767;9767.413955162678;9779.755506112333;8335.458195217321;9513.952430237874;9562.474063926482;9650.227981761478;9656.90343096567;9612.471314077722;9782.413055216673;9783.0706082922;9784.804303913917;9786.706398808046;9650.613975440974;9763.511824408752;9765.658201962897;9766.462844543546;9779.657711980117;9535.998720134356;9550.570224339852;9577.760555986086;9655.179309758609;9659.613615455373;40642.390364144565;40941.79529102365;41094.38358424626;41095.7945210272;41340.37989430161;3303.240254741423;3350.2294472271515;3382.475716263983;3392.932141357184;3445.638207988175;28115.437691246265;28176.436471270667;28594.714052859414;28876.566851497246;28896.27759306013;2313.363824948136;2735;2831.39125088105;2842.0052981456324;2975.747061499775;367908;369012.30987690046;369317;369605.1519742384;370396.1480192609;44745.10509789786;45546.316805247945;45670.976192618786;64507;65046;44892.55107448949;45074.77462612666;45211.77394113074;45250;45289.320660190126;15612.609684757972;15739.68520629581;15768.76346854798;15773.447929322649;15778;12611.432485538173;12719;12740.554080607135;12743.044271679475;12751.68120796969;13525;14097.59024097582;14744.852551474563;14768.187749673656;14876.330565124596;6301.369863013662;6370.554061215763;6394.520410969196;6469.256035555972;6474.805755827333;850.3282406898604;930.6556574067503;981.548487695668;981.7005813227034;1162.0935670177275;26018.6097208542;26630.6005409919;29167.124986250445;29594.556081658793;29657.85171074174;1072.587053984206;1090.7818436312768;1092;1120.865496140452;1186.7982442984714;14760;14811.555653330417;14939.761438348294;14998.175100369366;15140.621484462976;448723;456167;460342;461306;461889;57356.42643573594;57894.421055789746;57939.42060579424;58049;58100.83798324094;1325.0658285908605;1455.4614792526834;1474.741920163967;1482.6960473102988;1483.1101339196612;23980.880095599412;27355.443792306873;28221.71778282191;28477.288067798472;28988.27529311784;44179.558204417546;44576.55423445854;45153;45224.86937826581;45275.77362113168;291594;293503;295191;295446;295864;27964.720352796212;32328.928751768544;33164.34685225128;33257.66742332546;33324;40335.596644034355;41275.793621031706;41332.96667583335;42021;45910.85222869321;35574.93275201748;35639.82180089187;35735.92792216238;36106.45840312345;36762.26475470422;35020;35022.82488587541;35392.93821185369;35699.929002129975;35866.82066589755;35946.46080308745;35970.640293597775;36163.27673446569;37279.81360093182;37414;31504.84247578839;31746.141704231577;32313.35373292568;32367.838160809046;32477.700891964058;23568.764312357343;23619.937102830758;24664;24666.50666986686;24938.37654058663 23:13:46 INFO - PROCESS | 1958 | |2;jquery.html;294.7047725247538;339.35183798944024;354.18183994971616;358.9479525468807;364.5516015301179;19449.31927382542;19642.31251906182;19931;20371.796282037176;20376.796232037712;19122;19500.609987800235;20342;20377.083031263628;20383.490412739688;5567.6659400436;5719.027765279891;5769.16347129666;5771.134329850514;5782.681952492611;4088.3049881520215;4273.551277115905;4280.10117875245;5091.694498330094;5740.7129643517865;6299.275583307909;6326.2092238470195;6327.651979141146;6333.271673757507;6338.461230795388;5989.652328226158;6247.531435142337;6267.185265915447;6306.9369306307035;6310.021946598285;5374;5390.4879036491475;5398.109311963522;5403.7027963462;5404.351477822647;18885;24104;25351.619725704128;25604.74395256042;25645.3588660285;1914.712793081035;2355.8468699534474;2364.148906393697;2732.8360298382163;2784.2482529716863;9706.272029597738;9832.852507212398;9843.704688859345;10072;13575.321233938264;1661.4766348600153;1698.9915050424668;1745.8079611242754;1792.4801807475817;1847.6766565850921;98731.51902721464;102462;103116;104689;106165;10647.094996925192;10931.398773067398;10961.561537538568;11010.130590810484;11126.833097503544;13460.798088028687;13466.461341546228;13490.865091349157;13501.324933753272;13505.594832155051;8407.62165702545;8471.661133554711;8508.617112229964;8594.914050859536;8608.698695545625;7022.403095736818;8644.265237454887;8649.00536438305;8709.956450217709;8769.561521924006;3594.5686517618055;4231.936520952188;4321.3301938199;4367.694261401672;4379.277419225856;1532.3947040918774;1788.150628451475;1834.3488061738158;1837.7151541511087;1842.4656849513492;872.6596627315353;885.6944354197791;926.1803304075942;949.857521371786;1003.4280460137652;19148.94680792542;19560.510987225432;19706.113224904915;19804.306849260207;20064.6895990634;916.8166366726681;937.1378331934636;946.6828612414918;962.9711108666751;996.7009897030862;5067.67060141097;7878.842423151505;8540.871886921701;10533.052025317606;10544.736381590368;346538;352655;412804;566245;569928;91417;101651.49174254082;105184;113719.43140284246;115724.10689732655;1014.3609525998573;1033.5917312661456;1050.9632162874263;1052.957881684724;1054.987212276208;14138.293085345897;17582.91208543949;17731.73402398991;17770;17777.644447111245;49631.503684962685;49861;50012.49987500224;51328.97342053213;51739.48260517497;65054.674726626065;65851.34148658643;65856.67071664611;66070.67858642704;66075.66962165158;7459.552426854406;7669.3864490841715;7804.921950780419;7854.803629909298;7987.081485629227;9803.509824508603;10673.039426451656;11094.334339939629;12257.080718946294;12408.255504669749;9625.470599117116;10316.690499285034;10734.624288149877;10745.409002504937;10795.56817727282;10143.543540540546;10191.745206369604;10386.48067596602;10659.987301206373;10755.300905441121;10492;10537.26239163282;10761.408122553335;10832.945835270773;10934.781304374028;7677.428954024743;7687.231276872268;7746.457747957589;7829.608519573884;7979.84040319202;8724.956375218084;10339.224558158017;10645.946770266099;10699.625513107005;10832.24174307791 23:13:46 INFO - PROCESS | 1958 | |3;mootools.html;1606.4939544043625;1629.6985057764314;1906.8855868647881;1964.1554131723353;2035.5114772454615;8452.91547084529;8541.871871921927;8660.610272537735;8677.045524992254;8688.652453901845;7638.274363935418;7867.763967080997;8172.060213075498;8355.707550235744;8550.615222314995;2390.964135537964;2425.1754403502805;2426.1265944260053;2429.453372991072;2434.7078350597953;2043.38698390483;2140.357892632212;2376.370261880603;2435.062500937143;2441.5361081394476;2161.8919054047315;2382.285314405671;2440.365504968703;2442.206282958046;2450.15469662966;2375.548645757318;2417.5648383291;2423.3214699884147;2426.4904370082304;2436.610142377229;2413.54142712884;2419.7459266777087;2421.9878900605386;2422.503386805718;2425.551273014498;8539.975202975682;8630.093840146757;8630.136986301382;8631.482111073294;8745.431546949429;5177.767000484987;5210.400803907562;5346.572274218053;5378.596605254622;5400;3537.663921927413;3598.838052287653;3640.3629364861044;3642.7996460194677;3654.817259137059;1041.0890470838017;1048.103871190129;1070.9089727373182;1071.983920241197;1073.8711354637414;11481.770364592661;11510.079193664487;11510.42447877611;11530.365829879353;11537.077033837273;4631.58315751584;4778.474367819537;4803.975980120077;4813.109574728686;4845;9803.656872009446;9854.458004809661;9860.506974651382;9867.111959923497;9868.407895526292;5436.456354364532;5465.316835395575;5468.015757163748;5468.644538105011;5490.0941344677685;4967.205247160509;4974.303597496353;4975.477574854661;4979.153543897546;5009.248612708123;3643;3701.574318953301;3710.332140214787;3775.9993601695573;3786.5266841644793;1122.119136477861;1171.625079974417;1191.8331433599303;1195.1514424758518;1198.1493139870615;1134.478140055567;1140.931544107356;1163.778882012432;1267;1348.5347555093476;7697.884531732028;7703.807404814925;7719;7790.805229869298;7808.804779880435;1081.826218552863;1113.582406597526;1155.2779512804498;1184.0705046538426;1222.2910711787142;6126.908096378558;6159.353267906895;6163.013917773134;6179.443850053517;6204;10087.243456740774;10599.205059620404;10641.733956651145;10711.464426778786;10754.247202695737;9324.813503730024;10365.63720269787;10510.369377837354;10606.787864242826;10620.734481637866;7986.401019923413;8201.917980820235;8227.54748488827;8289;8364.665413383396;7649.411142119582;7731.961340193263;7813.843723125619;7831.725889593837;7834.334081603128;9174.587143578421;9335.159835614828;9444.008379120369;9467.526623668651;9550.140487356171;9566.760830979003;9885.85171222418;9886.50567471638;9892.109710126124;10018.499075046073;6916.308369163245;6961.8860982242595;6983.44132469391;7015.473839462163;7016.298370162943;6474.741010359533;7988.400869934662;8010.279074883289;8040.035195776544;8047.597620118853;6417.133686952202;7157.64211789398;7217.494775365674;7235.2764723529335;7298.4526160539235;6663.966680166568;7100.076989991475;7159.552342279802;7224.783256502314;7225.1329840419485;6433.260175079926;7719.073711154473;7719.073711154698;7722.691092356243;7728.420368472274;6906.965465172642;7003.369696727319;7004.229534751072;7009.1939426966555;7022.157341119098;6784.118064651564;6938.548994315353;6948.235694073547;6963.40811031068;6969.512134150561 23:13:46 INFO - PROCESS | 1958 | |4;prototype.html;324.59101532069593;325.9462188738858;329.1770573566085;332.51120852347043;336.59440374348895;5803.274590676166;6461.70922308496;6489.8377540561505;6514.1205937198465;6550.41046305833;6370.17187765591;6371.10804487371;6372.171617689693;6393.648349340784;6404.711787969541;4514.142312960527;4705.411823522059;4708.105459962613;4716.740579268156;4787.832425865086;4093.406456063884;4340.066885619591;4610.354550362935;4725.858224253261;4734.384530011093;4287.399764033038;4683.227267500858;4693.671442998992;4705.741184234866;4718.834840780573;4684.110019096361;4693.88265293367;4700.412448443927;4703.835365762182;4704.529547045302;3544.61009288978;3835.7506762060375;3892.0853599404118;4029.4560234368573;4069.023434375758;6118.256296955346;6126.387361263883;6131.662758548278;6161.599496032743;6169.629822210682;5524.475174858382;5550.666959982414;5550.77796888124;5558.527525160366;5560.582956278296;5967.7911273105665;6407.231132264158;6791.456683465311;6800.863982720318;6806.421454176401;4552.112338094073;4552.203364411248;4558.22510173268;4559.77201139945;4567.058999925019;5224.164133738584;6940.201876784184;7208.3512483876175;7224.819379515501;7302.963485182593;4623.12160689468;4663.603593694574;4737.8341758038305;4743.691660042086;4747.62019038483;4820.228763397839;4822.614190864722;4824;4824.758762061883;4830.275458681226;4674.532546745366;5601.859953501195;5605.103183490622;5608.859778505488;5610.775568977195;6567.770128045496;6878.621675807879;6881.759138430131;6893.75871844483;6900.447964162855;1597.8242393336957;1642.696101221254;1679.5885008173075;1681.697294487004;1687.3841048017384;1082.0586090101663;1093.8523299354486;1098.5441041967495;1109.1958330210693;1113.2263077161294;5190.273361729361;6260.24877014752;6366.236051673829;6375.545415015253;6449.871002579922;7187.2453392393045;7207.855842883113;7211.134663840373;7217.314355136358;7218.386437152796;6458.870822583616;6511.34886511345;6515.609063456208;6519.771807986698;6529.216494020748;3773.3019391412677;3812.3519001769764;3812.752171108869;3817.1983883384246;3821.636944490269;7197.784066478014;7513.737019204302;7526.435517336112;7551.546907185587;7589.8861517077285;5640.520555752807;7362.5214361066355;7377.22539133394;7408.888866667005;7417.517861338995;7530.774076777706;7531.774046778605;7539.472236943361;7553.395728341719;7560.168381478033;7176.102987126609;7178.964105179441;7179.497435179487;7181.605011724405;7202.49582529218;6681.398674119158;6974.407175390149;6995.96502017507;7024.332688394595;7040.3663670269925;6830.3852653259455;6842.623655698984;6872.278410766998;7518.398528117847;7546.622668866645;4505.279155335131;4524.8416305429155;4530.18456677788;4530.433695788027;4538.523455037173;5467.5625949923115;7146.3568278855155;7178.641067946686;7184.46116541251;7198.676059577437;6622.735090596515;6886.276940921131;6896.931030689629;6916.481263905328;6964.547304425196;6921.065656136559;6934.514583979073;6957.930420695729;6979.4765392594745;6982.1272340957385;6811.523193376416;6813.625250611264;6819;6819.556728812611;6821.454283657395;6171.321154672893;6512.8928082227085;6959.478039146983;6977.1278590176225;6978.825529361807;6496.415322620986;6564.540482166202;6816.318368163144;6819.488538359544;6848.246692863681 23:13:46 INFO - PROCESS | 1958 | |5;yui.html;682.6723172877018;696.0707455546844;712.576017269725;716.2801384608471;802.4623502253489;12124.75750484991;12283.14018018739;12313.63059108226;12318.014558835293;12328.198667086634;12224.938875305612;13497.730045399087;13506.932465337684;13631.863681363184;13684.315784210774;911.0388540090186;925.7778133248039;927.8144371125768;931.12009151352;936.7377134402378;911.3392790227099;924.0113079005467;925.5973651461636;930.4277869110516;931.5901003558413;969.5588507229229;971.4122955611859;972.6838777397339;973.6884197056945;974.7027156717198;969.1519920069903;969.9903000969971;970.088117169858;971.9319647624634;972.1202311907734;726.1358982810491;726.9563826170447;727.4943913979786;727.716190685633;730.4120183252479;12926.676833079155;12938.288394138319;12959.740805183843;12974.481020759158;13190.208587484782;11083;11240.606578769786;11293.491792869341;11405.258658187191;11440.256383335056;9250.676226332045;9268.049957705143;9324.627014919462;9488.905110948941;9658.3722058066;3364.6971772540587;3418.8632454701783;3446.172918499567;3458.2046129390383;3642.7996460194677;58237.835243294896;73464.63267683628;74383.25616743817;74577.62711186464;76323.23676763273;9473.715788526355;9488.33581649278;9515.611394452046;9749.415035097916;10201;20892.164313427293;21061.368158955254;21179.8941005294;21182.576348472943;21217.469563261042;7575.356094732009;7589;7599.316061554487;7629.580373079534;7667.118281397599;3851.1527463957887;3975.8608448704736;4137.338025915899;4141.399497072907;4207.621314081686;3440.1915549845767;3501.299740052;3501.3347463981763;3501.9299614007577;3507.210877552581;627.4635186915121;644.3395519592456;645.2934037229227;651.9152510173647;666.1140682891743;528.4451326107571;582.6154737873068;596.5257620191958;603.8943184942617;620.2804746494045;7696.307332340116;8015.559144247122;8162.591870406456;8200.138985406566;8257.256846883809;557.7099908047874;587.3569433627184;588.9793857214977;593.1221791748237;622.7384498510636;3732.2162345907122;3740.1958578905665;3745.0637340664834;3771.057235691077;3807.8857634271017;81757.36485270261;83139;85385.57307213548;86040.56979715187;86143.56928215318;59158;62577;73994.63002684953;76063;76377.85433218506;58635.706821466476;70214.64892675504;70404.64797675979;71000;71004.64497677478;8421.410501264852;8557.358198135289;8619.569021549023;8642.827143457222;8822.86765698528;42612.36081458843;43002.35496467493;43914;45441;46912.76543617397;60743;62951.740965179524;63394.68302658457;63678.68160659167;63832.68083659552;10684.946575267073;10768;10774.191935604704;10858.185636077484;11107.666769996913;11801.409929503663;11892.464839082435;12300.815487767512;12439.502419903103;12738.745225095632;9261.67584134552;11289.774204516028;11764.117691173025;11816.054715622902;12355.196912200678;9391.577379018097;11269.436528173723;11442.42787860587;11630.6510804676;11733.413329333669;10929.289596176222;10941;11019.228653994143;11134.387608681276;12191.756164876475;8335;8787.340949428946;8891.91108088911;9545.427274363561;9745.415275083518;8908.86636700437;9012.143846334588;9077.636894524145;9397.81204375895;9575.760605984906 23:13:46 INFO - PROCESS | 1958 | __end_tp_report 23:13:46 INFO - PROCESS | 1958 | __start_cc_report 23:13:46 INFO - PROCESS | 1958 | _x_x_mozilla_cycle_collect,1032 23:13:46 INFO - PROCESS | 1958 | __end_cc_report 23:13:46 INFO - PROCESS | 1958 | __startTimestamp1459836826720__endTimestamp 23:13:46 INFO - PROCESS | 1958 | 23:13:46 INFO - PROCESS | 1958 | ------- Summary: start ------- 23:13:46 INFO - PROCESS | 1958 | Number of tests: 6 23:13:46 INFO - PROCESS | 1958 | 23:13:46 INFO - PROCESS | 1958 | [#0] dojo.html Cycles:165 Average:5676.64 Median:5930.97 stddev:645.83 (10.9%) stddev-sans-first:611.94 23:13:46 INFO - PROCESS | 1958 | Values: 2971.0 3360.1 3411.3 3456.9 3464.6 5564.4 5618.0 5643.2 5652.6 5657.8 4927.4 5641.9 5660.7 5674.6 5686.6 5060.6 5067.5 5102.8 5119.7 5281.7 5198.6 5231.1 5242.4 5261.4 5311.8 5032.2 5116.0 5122.6 5125.4 5194.5 5075.7 5091.2 5093.7 5095.6 5195.9 5123.8 5138.9 5139.3 5173.4 5224.9 5594.5 5608.6 5618.2 5618.4 5664.2 6093.5 6105.5 6213.6 6213.7 6223.4 4913.6 6267.8 6281.8 6284.2 6308.3 5685.4 5761.5 5772.4 5783.4 5783.6 6161.2 6213.7 6217.3 6273.9 6278.5 6064.6 6069.8 6101.7 6105.8 6136.6 6177.2 6226.8 6240.5 6244.1 6245.4 6038.3 6083.1 6096.0 6114.1 6175.2 6133.4 6145.4 6168.0 6176.4 6188.4 4839.4 4852.0 4857.6 4860.9 4903.8 4292.1 4339.6 4375.6 4390.9 4454.2 5674.5 5685.5 5689.2 5690.4 5691.0 5155.9 6206.2 6261.8 6270.3 6273.3 5549.4 5628.0 5643.5 5655.1 5718.8 5291.8 5298.6 5307.7 5313.6 5337.8 5251.2 6029.5 6274.2 6287.3 6292.7 5906.8 6122.5 6151.7 6208.0 6232.4 6199.6 6272.5 6273.2 6283.3 6284.9 6115.9 6119.4 6127.9 6139.7 6174.6 6131.7 6174.8 6208.9 6229.8 6248.1 6049.8 6077.0 6089.8 6099.7 6143.2 6019.5 6045.9 6054.1 6065.9 6088.8 5800.9 5895.7 5957.8 5963.4 6013.3 6059.5 6070.1 6076.2 6080.3 6093.4 5799.5 5931.0 5937.3 5949.0 5951.8 23:13:46 INFO - PROCESS | 1958 | 23:13:46 INFO - PROCESS | 1958 | [#1] ext.html Cycles:180 Average:52451.46 Median:368460.15 stddev:100374.34 (27.2%) stddev-sans-first:100580.01 23:13:46 INFO - PROCESS | 1958 | Values: 460.8 578.6 590.9 620.2 637.0 29982.0 38779.8 39106.8 39139.0 39205.0 42015.0 42606.6 42687.6 42701.6 42728.0 9523.6 9755.1 9758.6 9767.4 9779.8 8335.5 9514.0 9562.5 9650.2 9656.9 9612.5 9782.4 9783.1 9784.8 9786.7 9650.6 9763.5 9765.7 9766.5 9779.7 9536.0 9550.6 9577.8 9655.2 9659.6 40642.4 40941.8 41094.4 41095.8 41340.4 3303.2 3350.2 3382.5 3392.9 3445.6 28115.4 28176.4 28594.7 28876.6 28896.3 2313.4 2735.0 2831.4 2842.0 2975.7 367908.0 369012.3 369317.0 369605.2 370396.1 44745.1 45546.3 45671.0 64507.0 65046.0 44892.6 45074.8 45211.8 45250.0 45289.3 15612.6 15739.7 15768.8 15773.4 15778.0 12611.4 12719.0 12740.6 12743.0 12751.7 13525.0 14097.6 14744.9 14768.2 14876.3 6301.4 6370.6 6394.5 6469.3 6474.8 850.3 930.7 981.5 981.7 1162.1 26018.6 26630.6 29167.1 29594.6 29657.9 1072.6 1090.8 1092.0 1120.9 1186.8 14760.0 14811.6 14939.8 14998.2 15140.6 448723.0 456167.0 460342.0 461306.0 461889.0 57356.4 57894.4 57939.4 58049.0 58100.8 1325.1 1455.5 1474.7 1482.7 1483.1 23980.9 27355.4 28221.7 28477.3 28988.3 44179.6 44576.6 45153.0 45224.9 45275.8 291594.0 293503.0 295191.0 295446.0 295864.0 27964.7 32328.9 33164.3 33257.7 33324.0 40335.6 41275.8 41333.0 42021.0 45910.9 35574.9 35639.8 35735.9 36106.5 36762.3 35020.0 35022.8 35392.9 35699.9 35866.8 35946.5 35970.6 36163.3 37279.8 37414.0 31504.8 31746.1 32313.4 32367.8 32477.7 23568.8 23619.9 24664.0 24666.5 24938.4 23:13:46 INFO - PROCESS | 1958 | 23:13:46 INFO - PROCESS | 1958 | [#2] jquery.html Cycles:180 Average:29048.90 Median:317.03 stddev:77310.33 (24385.9%) stddev-sans-first:77497.06 23:13:46 INFO - PROCESS | 1958 | Values: 294.7 339.4 354.2 358.9 364.6 19449.3 19642.3 19931.0 20371.8 20376.8 19122.0 19500.6 20342.0 20377.1 20383.5 5567.7 5719.0 5769.2 5771.1 5782.7 4088.3 4273.6 4280.1 5091.7 5740.7 6299.3 6326.2 6327.7 6333.3 6338.5 5989.7 6247.5 6267.2 6306.9 6310.0 5374.0 5390.5 5398.1 5403.7 5404.4 18885.0 24104.0 25351.6 25604.7 25645.4 1914.7 2355.8 2364.1 2732.8 2784.2 9706.3 9832.9 9843.7 10072.0 13575.3 1661.5 1699.0 1745.8 1792.5 1847.7 98731.5 102462.0 103116.0 104689.0 106165.0 10647.1 10931.4 10961.6 11010.1 11126.8 13460.8 13466.5 13490.9 13501.3 13505.6 8407.6 8471.7 8508.6 8594.9 8608.7 7022.4 8644.3 8649.0 8710.0 8769.6 3594.6 4231.9 4321.3 4367.7 4379.3 1532.4 1788.2 1834.3 1837.7 1842.5 872.7 885.7 926.2 949.9 1003.4 19148.9 19560.5 19706.1 19804.3 20064.7 916.8 937.1 946.7 963.0 996.7 5067.7 7878.8 8540.9 10533.1 10544.7 346538.0 352655.0 412804.0 566245.0 569928.0 91417.0 101651.5 105184.0 113719.4 115724.1 1014.4 1033.6 1051.0 1053.0 1055.0 14138.3 17582.9 17731.7 17770.0 17777.6 49631.5 49861.0 50012.5 51329.0 51739.5 65054.7 65851.3 65856.7 66070.7 66075.7 7459.6 7669.4 7804.9 7854.8 7987.1 9803.5 10673.0 11094.3 12257.1 12408.3 9625.5 10316.7 10734.6 10745.4 10795.6 10143.5 10191.7 10386.5 10660.0 10755.3 10492.0 10537.3 10761.4 10832.9 10934.8 7677.4 7687.2 7746.5 7829.6 7979.8 8725.0 10339.2 10645.9 10699.6 10832.2 23:13:46 INFO - PROCESS | 1958 | 23:13:46 INFO - PROCESS | 1958 | [#3] mootools.html Cycles:180 Average:5920.08 Median:5450.89 stddev:3092.78 (56.7%) stddev-sans-first:3084.46 23:13:46 INFO - PROCESS | 1958 | Values: 1606.5 1629.7 1906.9 1964.2 2035.5 8452.9 8541.9 8660.6 8677.0 8688.7 7638.3 7867.8 8172.1 8355.7 8550.6 2391.0 2425.2 2426.1 2429.5 2434.7 2043.4 2140.4 2376.4 2435.1 2441.5 2161.9 2382.3 2440.4 2442.2 2450.2 2375.5 2417.6 2423.3 2426.5 2436.6 2413.5 2419.7 2422.0 2422.5 2425.6 8540.0 8630.1 8630.1 8631.5 8745.4 5177.8 5210.4 5346.6 5378.6 5400.0 3537.7 3598.8 3640.4 3642.8 3654.8 1041.1 1048.1 1070.9 1072.0 1073.9 11481.8 11510.1 11510.4 11530.4 11537.1 4631.6 4778.5 4804.0 4813.1 4845.0 9803.7 9854.5 9860.5 9867.1 9868.4 5436.5 5465.3 5468.0 5468.6 5490.1 4967.2 4974.3 4975.5 4979.2 5009.2 3643.0 3701.6 3710.3 3776.0 3786.5 1122.1 1171.6 1191.8 1195.2 1198.1 1134.5 1140.9 1163.8 1267.0 1348.5 7697.9 7703.8 7719.0 7790.8 7808.8 1081.8 1113.6 1155.3 1184.1 1222.3 6126.9 6159.4 6163.0 6179.4 6204.0 10087.2 10599.2 10641.7 10711.5 10754.2 9324.8 10365.6 10510.4 10606.8 10620.7 7986.4 8201.9 8227.5 8289.0 8364.7 7649.4 7732.0 7813.8 7831.7 7834.3 9174.6 9335.2 9444.0 9467.5 9550.1 9566.8 9885.9 9886.5 9892.1 10018.5 6916.3 6961.9 6983.4 7015.5 7016.3 6474.7 7988.4 8010.3 8040.0 8047.6 6417.1 7157.6 7217.5 7235.3 7298.5 6664.0 7100.1 7159.6 7224.8 7225.1 6433.3 7719.1 7719.1 7722.7 7728.4 6907.0 7003.4 7004.2 7009.2 7022.2 6784.1 6938.5 6948.2 6963.4 6969.5 23:13:46 INFO - PROCESS | 1958 | 23:13:46 INFO - PROCESS | 1958 | [#4] prototype.html Cycles:180 Average:5609.59 Median:6371.64 stddev:1782.38 (28.0%) stddev-sans-first:1742.68 23:13:46 INFO - PROCESS | 1958 | Values: 324.6 325.9 329.2 332.5 336.6 5803.3 6461.7 6489.8 6514.1 6550.4 6370.2 6371.1 6372.2 6393.6 6404.7 4514.1 4705.4 4708.1 4716.7 4787.8 4093.4 4340.1 4610.4 4725.9 4734.4 4287.4 4683.2 4693.7 4705.7 4718.8 4684.1 4693.9 4700.4 4703.8 4704.5 3544.6 3835.8 3892.1 4029.5 4069.0 6118.3 6126.4 6131.7 6161.6 6169.6 5524.5 5550.7 5550.8 5558.5 5560.6 5967.8 6407.2 6791.5 6800.9 6806.4 4552.1 4552.2 4558.2 4559.8 4567.1 5224.2 6940.2 7208.4 7224.8 7303.0 4623.1 4663.6 4737.8 4743.7 4747.6 4820.2 4822.6 4824.0 4824.8 4830.3 4674.5 5601.9 5605.1 5608.9 5610.8 6567.8 6878.6 6881.8 6893.8 6900.4 1597.8 1642.7 1679.6 1681.7 1687.4 1082.1 1093.9 1098.5 1109.2 1113.2 5190.3 6260.2 6366.2 6375.5 6449.9 7187.2 7207.9 7211.1 7217.3 7218.4 6458.9 6511.3 6515.6 6519.8 6529.2 3773.3 3812.4 3812.8 3817.2 3821.6 7197.8 7513.7 7526.4 7551.5 7589.9 5640.5 7362.5 7377.2 7408.9 7417.5 7530.8 7531.8 7539.5 7553.4 7560.2 7176.1 7179.0 7179.5 7181.6 7202.5 6681.4 6974.4 6996.0 7024.3 7040.4 6830.4 6842.6 6872.3 7518.4 7546.6 4505.3 4524.8 4530.2 4530.4 4538.5 5467.6 7146.4 7178.6 7184.5 7198.7 6622.7 6886.3 6896.9 6916.5 6964.5 6921.1 6934.5 6957.9 6979.5 6982.1 6811.5 6813.6 6819.0 6819.6 6821.5 6171.3 6512.9 6959.5 6977.1 6978.8 6496.4 6564.5 6816.3 6819.5 6848.2 23:13:46 INFO - PROCESS | 1958 | 23:13:46 INFO - PROCESS | 1958 | [#5] yui.html Cycles:180 Average:17006.57 Median:63173.21 stddev:23464.65 (37.1%) stddev-sans-first:23498.46 23:13:46 INFO - PROCESS | 1958 | Values: 682.7 696.1 712.6 716.3 802.5 12124.8 12283.1 12313.6 12318.0 12328.2 12224.9 13497.7 13506.9 13631.9 13684.3 911.0 925.8 927.8 931.1 936.7 911.3 924.0 925.6 930.4 931.6 969.6 971.4 972.7 973.7 974.7 969.2 970.0 970.1 971.9 972.1 726.1 727.0 727.5 727.7 730.4 12926.7 12938.3 12959.7 12974.5 13190.2 11083.0 11240.6 11293.5 11405.3 11440.3 9250.7 9268.0 9324.6 9488.9 9658.4 3364.7 3418.9 3446.2 3458.2 3642.8 58237.8 73464.6 74383.3 74577.6 76323.2 9473.7 9488.3 9515.6 9749.4 10201.0 20892.2 21061.4 21179.9 21182.6 21217.5 7575.4 7589.0 7599.3 7629.6 7667.1 3851.2 3975.9 4137.3 4141.4 4207.6 3440.2 3501.3 3501.3 3501.9 3507.2 627.5 644.3 645.3 651.9 666.1 528.4 582.6 596.5 603.9 620.3 7696.3 8015.6 8162.6 8200.1 8257.3 557.7 587.4 589.0 593.1 622.7 3732.2 3740.2 3745.1 3771.1 3807.9 81757.4 83139.0 85385.6 86040.6 86143.6 59158.0 62577.0 73994.6 76063.0 76377.9 58635.7 70214.6 70404.6 71000.0 71004.6 8421.4 8557.4 8619.6 8642.8 8822.9 42612.4 43002.4 43914.0 45441.0 46912.8 60743.0 62951.7 63394.7 63678.7 63832.7 10684.9 10768.0 10774.2 10858.2 11107.7 11801.4 11892.5 12300.8 12439.5 12738.7 9261.7 11289.8 11764.1 11816.1 12355.2 9391.6 11269.4 11442.4 11630.7 11733.4 10929.3 10941.0 11019.2 11134.4 12191.8 8335.0 8787.3 8891.9 9545.4 9745.4 8908.9 9012.1 9077.6 9397.8 9575.8 23:13:46 INFO - PROCESS | 1958 | -------- Summary: end -------- 23:13:46 INFO - PROCESS | 1958 | 23:13:47 INFO - TEST-INFO | 1958: exit 0 23:13:47 INFO - TEST-OK | dromaeo_css | took 1112339ms 23:13:47 INFO - TEST-START | kraken 23:13:47 INFO - operating with platform_type : mac_ 23:13:47 INFO - Initialising browser for kraken test... 23:13:47 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpesTeVC/profile http://localhost:51894/getInfo.html) 23:13:49 INFO - PROCESS | 1962 | __metrics Screen width/height:1600/1200 23:13:49 INFO - PROCESS | 1962 | colorDepth:24 23:13:49 INFO - PROCESS | 1962 | Browser inner width/height: 1024/689 23:13:49 INFO - PROCESS | 1962 | __metrics 23:13:49 INFO - PROCESS | 1962 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:13:49 ERROR - PROCESS | 1962 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:13:49 INFO - TEST-INFO | 1962: exit 0 23:13:49 INFO - Browser initialized. 23:13:49 INFO - Running cycle 1/1 for kraken test... 23:13:49 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpesTeVC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:01 INFO - PROCESS | 1964 | RSS: Main: 236224512 23:14:01 INFO - PROCESS | 1964 | 23:14:04 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51894/tests/kraken/driver.html?testName=audio-beat-detection) 23:14:05 INFO - PROCESS | 1964 | RSS: Main: 283459584 23:14:05 INFO - PROCESS | 1964 | 23:14:07 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51894/tests/kraken/driver.html?testName=audio-dft) 23:14:08 INFO - PROCESS | 1964 | RSS: Main: 294240256 23:14:08 INFO - PROCESS | 1964 | 23:14:11 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51894/tests/kraken/driver.html?testName=audio-fft) 23:14:12 INFO - PROCESS | 1964 | RSS: Main: 277712896 23:14:12 INFO - PROCESS | 1964 | 23:14:14 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51894/tests/kraken/driver.html?testName=audio-oscillator) 23:14:15 INFO - PROCESS | 1964 | RSS: Main: 279142400 23:14:15 INFO - PROCESS | 1964 | 23:14:17 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51894/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:14:17 INFO - PROCESS | 1964 | RSS: Main: 280363008 23:14:17 INFO - PROCESS | 1964 | 23:14:20 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51894/tests/kraken/driver.html?testName=imaging-darkroom) 23:14:21 INFO - PROCESS | 1964 | RSS: Main: 282562560 23:14:21 INFO - PROCESS | 1964 | 23:14:23 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51894/tests/kraken/driver.html?testName=imaging-desaturate) 23:14:24 INFO - PROCESS | 1964 | RSS: Main: 281595904 23:14:24 INFO - PROCESS | 1964 | 23:14:27 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51894/tests/kraken/driver.html?testName=json-parse-financial) 23:14:27 INFO - PROCESS | 1964 | RSS: Main: 282120192 23:14:27 INFO - PROCESS | 1964 | 23:14:29 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51894/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:14:29 INFO - PROCESS | 1964 | RSS: Main: 315908096 23:14:29 INFO - PROCESS | 1964 | 23:14:31 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51894/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:14:32 INFO - PROCESS | 1964 | RSS: Main: 315580416 23:14:32 INFO - PROCESS | 1964 | 23:14:34 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51894/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:14:35 INFO - PROCESS | 1964 | RSS: Main: 322285568 23:14:35 INFO - PROCESS | 1964 | 23:14:37 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:14:38 INFO - PROCESS | 1964 | RSS: Main: 323493888 23:14:38 INFO - PROCESS | 1964 | 23:14:41 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:14:41 INFO - PROCESS | 1964 | RSS: Main: 323764224 23:14:41 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51894/tests/kraken/driver.html?testName=ai-astar) 23:14:43 INFO - PROCESS | 1964 | RSS: Main: 387158016 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | __start_tp_report 23:14:43 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 23:14:43 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 23:14:43 INFO - PROCESS | 1964 | |i|pagename|runs| 23:14:43 INFO - PROCESS | 1964 | |0;ai-astar;115;150;162;109;111;112;116;112;110;110 23:14:43 INFO - PROCESS | 1964 | |1;audio-beat-detection;162;116;143;158;120;146;163;147;163;122 23:14:43 INFO - PROCESS | 1964 | |2;audio-dft;187;184;187;184;183;188;187;180;224;254 23:14:43 INFO - PROCESS | 1964 | |3;audio-fft;80;74;84;85;82;85;83;101;81;55 23:14:43 INFO - PROCESS | 1964 | |4;audio-oscillator;91;92;128;80;78;79;114;80;79;120 23:14:43 INFO - PROCESS | 1964 | |5;imaging-gaussian-blur;86;85;87;85;87;87;127;84;88;84 23:14:43 INFO - PROCESS | 1964 | |6;imaging-darkroom;92;100;93;94;93;92;93;93;93;93 23:14:43 INFO - PROCESS | 1964 | |7;imaging-desaturate;85;87;85;88;87;86;88;85;102;141 23:14:43 INFO - PROCESS | 1964 | |8;json-parse-financial;53;56;53;53;53;53;53;64;54;53 23:14:43 INFO - PROCESS | 1964 | |9;json-stringify-tinderbox;63;70;72;69;68;68;67;68;65;66 23:14:43 INFO - PROCESS | 1964 | |10;stanford-crypto-aes;85;102;108;108;92;84;91;105;108;105 23:14:43 INFO - PROCESS | 1964 | |11;stanford-crypto-ccm;128;123;133;127;120;104;121;121;140;131 23:14:43 INFO - PROCESS | 1964 | |12;stanford-crypto-pbkdf2;139;138;141;140;138;128;143;138;140;141 23:14:43 INFO - PROCESS | 1964 | |13;stanford-crypto-sha256-iterative;67;66;64;66;67;67;66;66;65;66 23:14:43 INFO - PROCESS | 1964 | __end_tp_report 23:14:43 INFO - PROCESS | 1964 | __start_cc_report 23:14:43 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,1313 23:14:43 INFO - PROCESS | 1964 | __end_cc_report 23:14:43 INFO - PROCESS | 1964 | __startTimestamp1459836883633__endTimestamp 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | ------- Summary: start ------- 23:14:43 INFO - PROCESS | 1964 | Number of tests: 14 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#0] ai-astar Cycles:10 Average:120.70 Median:113.50 stddev:18.94 (16.7%) stddev-sans-first:19.98 23:14:43 INFO - PROCESS | 1964 | Values: 115.0 150.0 162.0 109.0 111.0 112.0 116.0 112.0 110.0 110.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:152.50 stddev:18.56 (12.2%) stddev-sans-first:18.51 23:14:43 INFO - PROCESS | 1964 | Values: 162.0 116.0 143.0 158.0 120.0 146.0 163.0 147.0 163.0 122.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#2] audio-dft Cycles:10 Average:195.80 Median:187.00 stddev:23.96 (12.8%) stddev-sans-first:25.20 23:14:43 INFO - PROCESS | 1964 | Values: 187.0 184.0 187.0 184.0 183.0 188.0 187.0 180.0 224.0 254.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#3] audio-fft Cycles:10 Average:81.00 Median:82.50 stddev:11.41 (13.8%) stddev-sans-first:12.10 23:14:43 INFO - PROCESS | 1964 | Values: 80.0 74.0 84.0 85.0 82.0 85.0 83.0 101.0 81.0 55.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.50 stddev:19.27 (24.2%) stddev-sans-first:20.41 23:14:43 INFO - PROCESS | 1964 | Values: 91.0 92.0 128.0 80.0 78.0 79.0 114.0 80.0 79.0 120.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:86.50 stddev:13.07 (15.1%) stddev-sans-first:13.79 23:14:43 INFO - PROCESS | 1964 | Values: 86.0 85.0 87.0 85.0 87.0 87.0 127.0 84.0 88.0 84.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:93.00 stddev:2.32 (2.5%) stddev-sans-first:2.39 23:14:43 INFO - PROCESS | 1964 | Values: 92.0 100.0 93.0 94.0 93.0 92.0 93.0 93.0 93.0 93.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#7] imaging-desaturate Cycles:10 Average:93.40 Median:86.50 stddev:17.47 (20.2%) stddev-sans-first:18.26 23:14:43 INFO - PROCESS | 1964 | Values: 85.0 87.0 85.0 88.0 87.0 86.0 88.0 85.0 102.0 141.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:53.00 stddev:3.47 (6.6%) stddev-sans-first:3.64 23:14:43 INFO - PROCESS | 1964 | Values: 53.0 56.0 53.0 53.0 53.0 53.0 53.0 64.0 54.0 53.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:2.55 (3.7%) stddev-sans-first:2.09 23:14:43 INFO - PROCESS | 1964 | Values: 63.0 70.0 72.0 69.0 68.0 68.0 67.0 68.0 65.0 66.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#10] stanford-crypto-aes Cycles:10 Average:98.80 Median:96.00 stddev:9.76 (10.2%) stddev-sans-first:8.99 23:14:43 INFO - PROCESS | 1964 | Values: 85.0 102.0 108.0 108.0 92.0 84.0 91.0 105.0 108.0 105.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:127.50 stddev:9.66 (7.6%) stddev-sans-first:10.17 23:14:43 INFO - PROCESS | 1964 | Values: 128.0 123.0 133.0 127.0 120.0 104.0 121.0 121.0 140.0 131.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.60 Median:140.00 stddev:4.06 (2.9%) stddev-sans-first:4.30 23:14:43 INFO - PROCESS | 1964 | Values: 139.0 138.0 141.0 140.0 138.0 128.0 143.0 138.0 140.0 141.0 23:14:43 INFO - PROCESS | 1964 | 23:14:43 INFO - PROCESS | 1964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 23:14:43 INFO - PROCESS | 1964 | Values: 67.0 66.0 64.0 66.0 67.0 67.0 66.0 66.0 65.0 66.0 23:14:43 INFO - PROCESS | 1964 | -------- Summary: end -------- 23:14:43 INFO - PROCESS | 1964 | 23:14:44 INFO - TEST-INFO | 1964: exit 0 23:14:44 INFO - TEST-OK | kraken | took 57024ms 23:14:44 INFO - SUITE-END | took 1169s 23:14:44 INFO - Completed test suite (00:19:29) 23:14:44 INFO - javascript benchmark 23:14:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2970.9851450742744, 3360.092774950763, 3411.3006833599097, 3456.9308613827716, 3464.566929133858, 5564.387917329091, 5618.0, 5643.2099506069135, 5652.604317697757, 5657.773689052438, 4927.408710954682, 5641.8589535261635, 5660.745266463009, 5674.631148975324, 5686.63036902601, 5060.620453465986, 5067.5185857343495, 5102.795888164469, 5119.744012799364, 5281.656692314988, 5198.584113270948, 5231.084560201968, 5242.449542797989, 5261.447548007462, 5311.840644780663, 5032.245163225509, 5115.974420127913, 5122.641415100945, 5125.359330083739, 5194.506521880416, 5075.720835354054, 5091.159958606825, 5093.694378337312, 5095.617828662828, 5195.896082078338, 5123.8206662767, 5138.897222055575, 5139.254808052849, 5173.379194496647, 5224.947750522484, 5594.4964953154, 5608.635438696512, 5618.213450116987, 5618.410066942953, 5664.150377443375, 6093.542984276152, 6105.542084343648, 6213.627182369072, 6213.689315534205, 6223.408776166257, 4913.606911447076, 6267.843303917393, 6281.842953926189, 6284.151639528696, 6308.337624549402, 5685.403032681592, 5761.48146666802, 5772.422757724236, 5783.363829978741, 5783.624064435799, 6161.199044124325, 6213.65824879636, 6217.347178546278, 6273.874522509615, 6278.529110316653, 6064.616930969446, 6069.848253793602, 6101.694915254219, 6105.763021687103, 6136.570440069152, 6177.163726227764, 6226.813195604139, 6240.500759939194, 6244.12582238487, 6245.406686364788, 6038.30559485656, 6083.087536869417, 6095.982463883823, 6114.114890844268, 6175.166352542439, 6133.44798968095, 6145.371476558716, 6168.0439531872635, 6176.444120029129, 6188.381161883775, 4839.443464001614, 4852.0, 4857.562819346205, 4860.902781944341, 4903.754812259373, 4292.098659281586, 4339.5660433956355, 4375.606195442426, 4390.868273951786, 4454.242778727624, 5674.4892959633835, 5685.516731077904, 5689.231953686282, 5690.374058853523, 5690.971545142331, 5155.948440515622, 6206.162168107247, 6261.812145635638, 6270.31026587075, 6273.278572964167, 5549.389567147691, 5628.0, 5643.463870932255, 5655.123455864347, 5718.771249150071, 5291.788328466818, 5298.629095963245, 5307.734613269321, 5313.628046036741, 5337.786488540492, 5251.238570407269, 6029.517638588903, 6274.152989346379, 6287.339829317947, 6292.685365731787, 5906.793262235973, 6122.540809439399, 6151.661658608819, 6208.0, 6232.376762323732, 6199.597026193283, 6272.498200143887, 6273.215848018997, 6283.308836027942, 6284.937150628435, 6115.938840611715, 6119.388061193845, 6127.877442451215, 6139.693015349304, 6174.629522228681, 6131.724072416841, 6174.845628859314, 6208.875822483435, 6229.750809967551, 6248.062790581449, 6049.758009679739, 6076.997295446378, 6089.786857459968, 6099.748120842393, 6143.201383820075, 6019.488343490677, 6045.879082418415, 6054.061620448838, 6065.909011364744, 6088.847778805565, 5800.854978625568, 5895.734691938787, 5957.76168953237, 5963.4334738199805, 6013.278406591062, 6059.545534085049, 6070.119832624333, 6076.179715738495, 6080.270367555921, 6093.36019717941, 5799.4780469757925, 5930.970345148246, 5937.287525496968, 5949.0, 5951.791687290924], "unit": "score", "name": "dojo.html", "value": 5635.754957189416}, {"lowerIsBetter": false, "replicates": [460.83870645274135, 578.6065475476677, 590.9172715819786, 620.1503939602743, 637.047613817343, 29982.0, 38779.806100969494, 39106.8044659777, 39139.02152446187, 39205.0, 42015.0, 42606.57393426065, 42687.57312426875, 42701.57298427015, 42728.0, 9523.57143928525, 9755.122039016487, 9758.609655613767, 9767.413955162678, 9779.755506112333, 8335.458195217321, 9513.952430237874, 9562.474063926482, 9650.227981761478, 9656.90343096567, 9612.471314077722, 9782.413055216673, 9783.0706082922, 9784.804303913917, 9786.706398808046, 9650.613975440974, 9763.511824408752, 9765.658201962897, 9766.462844543546, 9779.657711980117, 9535.998720134356, 9550.570224339852, 9577.760555986086, 9655.179309758609, 9659.613615455373, 40642.390364144565, 40941.79529102365, 41094.38358424626, 41095.7945210272, 41340.37989430161, 3303.240254741423, 3350.2294472271515, 3382.475716263983, 3392.932141357184, 3445.638207988175, 28115.437691246265, 28176.436471270667, 28594.714052859414, 28876.566851497246, 28896.27759306013, 2313.363824948136, 2735.0, 2831.39125088105, 2842.0052981456324, 2975.747061499775, 367908.0, 369012.30987690046, 369317.0, 369605.1519742384, 370396.1480192609, 44745.10509789786, 45546.316805247945, 45670.976192618786, 64507.0, 65046.0, 44892.55107448949, 45074.77462612666, 45211.77394113074, 45250.0, 45289.320660190126, 15612.609684757972, 15739.68520629581, 15768.76346854798, 15773.447929322649, 15778.0, 12611.432485538173, 12719.0, 12740.554080607135, 12743.044271679475, 12751.68120796969, 13525.0, 14097.59024097582, 14744.852551474563, 14768.187749673656, 14876.330565124596, 6301.369863013662, 6370.554061215763, 6394.520410969196, 6469.256035555972, 6474.805755827333, 850.3282406898604, 930.6556574067503, 981.548487695668, 981.7005813227034, 1162.0935670177275, 26018.6097208542, 26630.6005409919, 29167.124986250445, 29594.556081658793, 29657.85171074174, 1072.587053984206, 1090.7818436312768, 1092.0, 1120.865496140452, 1186.7982442984714, 14760.0, 14811.555653330417, 14939.761438348294, 14998.175100369366, 15140.621484462976, 448723.0, 456167.0, 460342.0, 461306.0, 461889.0, 57356.42643573594, 57894.421055789746, 57939.42060579424, 58049.0, 58100.83798324094, 1325.0658285908605, 1455.4614792526834, 1474.741920163967, 1482.6960473102988, 1483.1101339196612, 23980.880095599412, 27355.443792306873, 28221.71778282191, 28477.288067798472, 28988.27529311784, 44179.558204417546, 44576.55423445854, 45153.0, 45224.86937826581, 45275.77362113168, 291594.0, 293503.0, 295191.0, 295446.0, 295864.0, 27964.720352796212, 32328.928751768544, 33164.34685225128, 33257.66742332546, 33324.0, 40335.596644034355, 41275.793621031706, 41332.96667583335, 42021.0, 45910.85222869321, 35574.93275201748, 35639.82180089187, 35735.92792216238, 36106.45840312345, 36762.26475470422, 35020.0, 35022.82488587541, 35392.93821185369, 35699.929002129975, 35866.82066589755, 35946.46080308745, 35970.640293597775, 36163.27673446569, 37279.81360093182, 37414.0, 31504.84247578839, 31746.141704231577, 32313.35373292568, 32367.838160809046, 32477.700891964058, 23568.764312357343, 23619.937102830758, 24664.0, 24666.50666986686, 24938.37654058663], "unit": "score", "name": "ext.html", "value": 18504.983087399945}, {"lowerIsBetter": false, "replicates": [294.7047725247538, 339.35183798944024, 354.18183994971616, 358.9479525468807, 364.5516015301179, 19449.31927382542, 19642.31251906182, 19931.0, 20371.796282037176, 20376.796232037712, 19122.0, 19500.609987800235, 20342.0, 20377.083031263628, 20383.490412739688, 5567.6659400436, 5719.027765279891, 5769.16347129666, 5771.134329850514, 5782.681952492611, 4088.3049881520215, 4273.551277115905, 4280.10117875245, 5091.694498330094, 5740.7129643517865, 6299.275583307909, 6326.2092238470195, 6327.651979141146, 6333.271673757507, 6338.461230795388, 5989.652328226158, 6247.531435142337, 6267.185265915447, 6306.9369306307035, 6310.021946598285, 5374.0, 5390.4879036491475, 5398.109311963522, 5403.7027963462, 5404.351477822647, 18885.0, 24104.0, 25351.619725704128, 25604.74395256042, 25645.3588660285, 1914.712793081035, 2355.8468699534474, 2364.148906393697, 2732.8360298382163, 2784.2482529716863, 9706.272029597738, 9832.852507212398, 9843.704688859345, 10072.0, 13575.321233938264, 1661.4766348600153, 1698.9915050424668, 1745.8079611242754, 1792.4801807475817, 1847.6766565850921, 98731.51902721464, 102462.0, 103116.0, 104689.0, 106165.0, 10647.094996925192, 10931.398773067398, 10961.561537538568, 11010.130590810484, 11126.833097503544, 13460.798088028687, 13466.461341546228, 13490.865091349157, 13501.324933753272, 13505.594832155051, 8407.62165702545, 8471.661133554711, 8508.617112229964, 8594.914050859536, 8608.698695545625, 7022.403095736818, 8644.265237454887, 8649.00536438305, 8709.956450217709, 8769.561521924006, 3594.5686517618055, 4231.936520952188, 4321.3301938199, 4367.694261401672, 4379.277419225856, 1532.3947040918774, 1788.150628451475, 1834.3488061738158, 1837.7151541511087, 1842.4656849513492, 872.6596627315353, 885.6944354197791, 926.1803304075942, 949.857521371786, 1003.4280460137652, 19148.94680792542, 19560.510987225432, 19706.113224904915, 19804.306849260207, 20064.6895990634, 916.8166366726681, 937.1378331934636, 946.6828612414918, 962.9711108666751, 996.7009897030862, 5067.67060141097, 7878.842423151505, 8540.871886921701, 10533.052025317606, 10544.736381590368, 346538.0, 352655.0, 412804.0, 566245.0, 569928.0, 91417.0, 101651.49174254082, 105184.0, 113719.43140284246, 115724.10689732655, 1014.3609525998573, 1033.5917312661456, 1050.9632162874263, 1052.957881684724, 1054.987212276208, 14138.293085345897, 17582.91208543949, 17731.73402398991, 17770.0, 17777.644447111245, 49631.503684962685, 49861.0, 50012.49987500224, 51328.97342053213, 51739.48260517497, 65054.674726626065, 65851.34148658643, 65856.67071664611, 66070.67858642704, 66075.66962165158, 7459.552426854406, 7669.3864490841715, 7804.921950780419, 7854.803629909298, 7987.081485629227, 9803.509824508603, 10673.039426451656, 11094.334339939629, 12257.080718946294, 12408.255504669749, 9625.470599117116, 10316.690499285034, 10734.624288149877, 10745.409002504937, 10795.56817727282, 10143.543540540546, 10191.745206369604, 10386.48067596602, 10659.987301206373, 10755.300905441121, 10492.0, 10537.26239163282, 10761.408122553335, 10832.945835270773, 10934.781304374028, 7677.428954024743, 7687.231276872268, 7746.457747957589, 7829.608519573884, 7979.84040319202, 8724.956375218084, 10339.224558158017, 10645.946770266099, 10699.625513107005, 10832.24174307791], "unit": "score", "name": "jquery.html", "value": 9000.420965853886}, {"lowerIsBetter": false, "replicates": [1606.4939544043625, 1629.6985057764314, 1906.8855868647881, 1964.1554131723353, 2035.5114772454615, 8452.91547084529, 8541.871871921927, 8660.610272537735, 8677.045524992254, 8688.652453901845, 7638.274363935418, 7867.763967080997, 8172.060213075498, 8355.707550235744, 8550.615222314995, 2390.964135537964, 2425.1754403502805, 2426.1265944260053, 2429.453372991072, 2434.7078350597953, 2043.38698390483, 2140.357892632212, 2376.370261880603, 2435.062500937143, 2441.5361081394476, 2161.8919054047315, 2382.285314405671, 2440.365504968703, 2442.206282958046, 2450.15469662966, 2375.548645757318, 2417.5648383291, 2423.3214699884147, 2426.4904370082304, 2436.610142377229, 2413.54142712884, 2419.7459266777087, 2421.9878900605386, 2422.503386805718, 2425.551273014498, 8539.975202975682, 8630.093840146757, 8630.136986301382, 8631.482111073294, 8745.431546949429, 5177.767000484987, 5210.400803907562, 5346.572274218053, 5378.596605254622, 5400.0, 3537.663921927413, 3598.838052287653, 3640.3629364861044, 3642.7996460194677, 3654.817259137059, 1041.0890470838017, 1048.103871190129, 1070.9089727373182, 1071.983920241197, 1073.8711354637414, 11481.770364592661, 11510.079193664487, 11510.42447877611, 11530.365829879353, 11537.077033837273, 4631.58315751584, 4778.474367819537, 4803.975980120077, 4813.109574728686, 4845.0, 9803.656872009446, 9854.458004809661, 9860.506974651382, 9867.111959923497, 9868.407895526292, 5436.456354364532, 5465.316835395575, 5468.015757163748, 5468.644538105011, 5490.0941344677685, 4967.205247160509, 4974.303597496353, 4975.477574854661, 4979.153543897546, 5009.248612708123, 3643.0, 3701.574318953301, 3710.332140214787, 3775.9993601695573, 3786.5266841644793, 1122.119136477861, 1171.625079974417, 1191.8331433599303, 1195.1514424758518, 1198.1493139870615, 1134.478140055567, 1140.931544107356, 1163.778882012432, 1267.0, 1348.5347555093476, 7697.884531732028, 7703.807404814925, 7719.0, 7790.805229869298, 7808.804779880435, 1081.826218552863, 1113.582406597526, 1155.2779512804498, 1184.0705046538426, 1222.2910711787142, 6126.908096378558, 6159.353267906895, 6163.013917773134, 6179.443850053517, 6204.0, 10087.243456740774, 10599.205059620404, 10641.733956651145, 10711.464426778786, 10754.247202695737, 9324.813503730024, 10365.63720269787, 10510.369377837354, 10606.787864242826, 10620.734481637866, 7986.401019923413, 8201.917980820235, 8227.54748488827, 8289.0, 8364.665413383396, 7649.411142119582, 7731.961340193263, 7813.843723125619, 7831.725889593837, 7834.334081603128, 9174.587143578421, 9335.159835614828, 9444.008379120369, 9467.526623668651, 9550.140487356171, 9566.760830979003, 9885.85171222418, 9886.50567471638, 9892.109710126124, 10018.499075046073, 6916.308369163245, 6961.8860982242595, 6983.44132469391, 7015.473839462163, 7016.298370162943, 6474.741010359533, 7988.400869934662, 8010.279074883289, 8040.035195776544, 8047.597620118853, 6417.133686952202, 7157.64211789398, 7217.494775365674, 7235.2764723529335, 7298.4526160539235, 6663.966680166568, 7100.076989991475, 7159.552342279802, 7224.783256502314, 7225.1329840419485, 6433.260175079926, 7719.073711154473, 7719.073711154698, 7722.691092356243, 7728.420368472274, 6906.965465172642, 7003.369696727319, 7004.229534751072, 7009.1939426966555, 7022.157341119098, 6784.118064651564, 6938.548994315353, 6948.235694073547, 6963.40811031068, 6969.512134150561], "unit": "score", "name": "mootools.html", "value": 4843.555647649021}, {"lowerIsBetter": false, "replicates": [324.59101532069593, 325.9462188738858, 329.1770573566085, 332.51120852347043, 336.59440374348895, 5803.274590676166, 6461.70922308496, 6489.8377540561505, 6514.1205937198465, 6550.41046305833, 6370.17187765591, 6371.10804487371, 6372.171617689693, 6393.648349340784, 6404.711787969541, 4514.142312960527, 4705.411823522059, 4708.105459962613, 4716.740579268156, 4787.832425865086, 4093.406456063884, 4340.066885619591, 4610.354550362935, 4725.858224253261, 4734.384530011093, 4287.399764033038, 4683.227267500858, 4693.671442998992, 4705.741184234866, 4718.834840780573, 4684.110019096361, 4693.88265293367, 4700.412448443927, 4703.835365762182, 4704.529547045302, 3544.61009288978, 3835.7506762060375, 3892.0853599404118, 4029.4560234368573, 4069.023434375758, 6118.256296955346, 6126.387361263883, 6131.662758548278, 6161.599496032743, 6169.629822210682, 5524.475174858382, 5550.666959982414, 5550.77796888124, 5558.527525160366, 5560.582956278296, 5967.7911273105665, 6407.231132264158, 6791.456683465311, 6800.863982720318, 6806.421454176401, 4552.112338094073, 4552.203364411248, 4558.22510173268, 4559.77201139945, 4567.058999925019, 5224.164133738584, 6940.201876784184, 7208.3512483876175, 7224.819379515501, 7302.963485182593, 4623.12160689468, 4663.603593694574, 4737.8341758038305, 4743.691660042086, 4747.62019038483, 4820.228763397839, 4822.614190864722, 4824.0, 4824.758762061883, 4830.275458681226, 4674.532546745366, 5601.859953501195, 5605.103183490622, 5608.859778505488, 5610.775568977195, 6567.770128045496, 6878.621675807879, 6881.759138430131, 6893.75871844483, 6900.447964162855, 1597.8242393336957, 1642.696101221254, 1679.5885008173075, 1681.697294487004, 1687.3841048017384, 1082.0586090101663, 1093.8523299354486, 1098.5441041967495, 1109.1958330210693, 1113.2263077161294, 5190.273361729361, 6260.24877014752, 6366.236051673829, 6375.545415015253, 6449.871002579922, 7187.2453392393045, 7207.855842883113, 7211.134663840373, 7217.314355136358, 7218.386437152796, 6458.870822583616, 6511.34886511345, 6515.609063456208, 6519.771807986698, 6529.216494020748, 3773.3019391412677, 3812.3519001769764, 3812.752171108869, 3817.1983883384246, 3821.636944490269, 7197.784066478014, 7513.737019204302, 7526.435517336112, 7551.546907185587, 7589.8861517077285, 5640.520555752807, 7362.5214361066355, 7377.22539133394, 7408.888866667005, 7417.517861338995, 7530.774076777706, 7531.774046778605, 7539.472236943361, 7553.395728341719, 7560.168381478033, 7176.102987126609, 7178.964105179441, 7179.497435179487, 7181.605011724405, 7202.49582529218, 6681.398674119158, 6974.407175390149, 6995.96502017507, 7024.332688394595, 7040.3663670269925, 6830.3852653259455, 6842.623655698984, 6872.278410766998, 7518.398528117847, 7546.622668866645, 4505.279155335131, 4524.8416305429155, 4530.18456677788, 4530.433695788027, 4538.523455037173, 5467.5625949923115, 7146.3568278855155, 7178.641067946686, 7184.46116541251, 7198.676059577437, 6622.735090596515, 6886.276940921131, 6896.931030689629, 6916.481263905328, 6964.547304425196, 6921.065656136559, 6934.514583979073, 6957.930420695729, 6979.4765392594745, 6982.1272340957385, 6811.523193376416, 6813.625250611264, 6819.0, 6819.556728812611, 6821.454283657395, 6171.321154672893, 6512.8928082227085, 6959.478039146983, 6977.1278590176225, 6978.825529361807, 6496.415322620986, 6564.540482166202, 6816.318368163144, 6819.488538359544, 6848.246692863681], "unit": "score", "name": "prototype.html", "value": 5026.5144138378855}, {"lowerIsBetter": false, "replicates": [682.6723172877018, 696.0707455546844, 712.576017269725, 716.2801384608471, 802.4623502253489, 12124.75750484991, 12283.14018018739, 12313.63059108226, 12318.014558835293, 12328.198667086634, 12224.938875305612, 13497.730045399087, 13506.932465337684, 13631.863681363184, 13684.315784210774, 911.0388540090186, 925.7778133248039, 927.8144371125768, 931.12009151352, 936.7377134402378, 911.3392790227099, 924.0113079005467, 925.5973651461636, 930.4277869110516, 931.5901003558413, 969.5588507229229, 971.4122955611859, 972.6838777397339, 973.6884197056945, 974.7027156717198, 969.1519920069903, 969.9903000969971, 970.088117169858, 971.9319647624634, 972.1202311907734, 726.1358982810491, 726.9563826170447, 727.4943913979786, 727.716190685633, 730.4120183252479, 12926.676833079155, 12938.288394138319, 12959.740805183843, 12974.481020759158, 13190.208587484782, 11083.0, 11240.606578769786, 11293.491792869341, 11405.258658187191, 11440.256383335056, 9250.676226332045, 9268.049957705143, 9324.627014919462, 9488.905110948941, 9658.3722058066, 3364.6971772540587, 3418.8632454701783, 3446.172918499567, 3458.2046129390383, 3642.7996460194677, 58237.835243294896, 73464.63267683628, 74383.25616743817, 74577.62711186464, 76323.23676763273, 9473.715788526355, 9488.33581649278, 9515.611394452046, 9749.415035097916, 10201.0, 20892.164313427293, 21061.368158955254, 21179.8941005294, 21182.576348472943, 21217.469563261042, 7575.356094732009, 7589.0, 7599.316061554487, 7629.580373079534, 7667.118281397599, 3851.1527463957887, 3975.8608448704736, 4137.338025915899, 4141.399497072907, 4207.621314081686, 3440.1915549845767, 3501.299740052, 3501.3347463981763, 3501.9299614007577, 3507.210877552581, 627.4635186915121, 644.3395519592456, 645.2934037229227, 651.9152510173647, 666.1140682891743, 528.4451326107571, 582.6154737873068, 596.5257620191958, 603.8943184942617, 620.2804746494045, 7696.307332340116, 8015.559144247122, 8162.591870406456, 8200.138985406566, 8257.256846883809, 557.7099908047874, 587.3569433627184, 588.9793857214977, 593.1221791748237, 622.7384498510636, 3732.2162345907122, 3740.1958578905665, 3745.0637340664834, 3771.057235691077, 3807.8857634271017, 81757.36485270261, 83139.0, 85385.57307213548, 86040.56979715187, 86143.56928215318, 59158.0, 62577.0, 73994.63002684953, 76063.0, 76377.85433218506, 58635.706821466476, 70214.64892675504, 70404.64797675979, 71000.0, 71004.64497677478, 8421.410501264852, 8557.358198135289, 8619.569021549023, 8642.827143457222, 8822.86765698528, 42612.36081458843, 43002.35496467493, 43914.0, 45441.0, 46912.76543617397, 60743.0, 62951.740965179524, 63394.68302658457, 63678.68160659167, 63832.68083659552, 10684.946575267073, 10768.0, 10774.191935604704, 10858.185636077484, 11107.666769996913, 11801.409929503663, 11892.464839082435, 12300.815487767512, 12439.502419903103, 12738.745225095632, 9261.67584134552, 11289.774204516028, 11764.117691173025, 11816.054715622902, 12355.196912200678, 9391.577379018097, 11269.436528173723, 11442.42787860587, 11630.6510804676, 11733.413329333669, 10929.289596176222, 10941.0, 11019.228653994143, 11134.387608681276, 12191.756164876475, 8335.0, 8787.340949428946, 8891.91108088911, 9545.427274363561, 9745.415275083518, 8908.86636700437, 9012.143846334588, 9077.636894524145, 9397.81204375895, 9575.760605984906], "unit": "score", "name": "yui.html", "value": 6696.756474922593}], "name": "dromaeo_css", "value": 7313.727794195724}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 150.0, 162.0, 109.0, 111.0, 112.0, 116.0, 112.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 120.7}, {"lowerIsBetter": true, "replicates": [162.0, 116.0, 143.0, 158.0, 120.0, 146.0, 163.0, 147.0, 163.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [187.0, 184.0, 187.0, 184.0, 183.0, 188.0, 187.0, 180.0, 224.0, 254.0], "unit": "score", "name": "audio-dft", "value": 195.8}, {"lowerIsBetter": true, "replicates": [80.0, 74.0, 84.0, 85.0, 82.0, 85.0, 83.0, 101.0, 81.0, 55.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 128.0, 80.0, 78.0, 79.0, 114.0, 80.0, 79.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 94.1}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 87.0, 85.0, 87.0, 87.0, 127.0, 84.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.0}, {"lowerIsBetter": true, "replicates": [92.0, 100.0, 93.0, 94.0, 93.0, 92.0, 93.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.6}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 85.0, 88.0, 87.0, 86.0, 88.0, 85.0, 102.0, 141.0], "unit": "score", "name": "imaging-desaturate", "value": 93.4}, {"lowerIsBetter": true, "replicates": [53.0, 56.0, 53.0, 53.0, 53.0, 53.0, 53.0, 64.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.5}, {"lowerIsBetter": true, "replicates": [63.0, 70.0, 72.0, 69.0, 68.0, 68.0, 67.0, 68.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [85.0, 102.0, 108.0, 108.0, 92.0, 84.0, 91.0, 105.0, 108.0, 105.0], "unit": "score", "name": "stanford-crypto-aes", "value": 98.8}, {"lowerIsBetter": true, "replicates": [128.0, 123.0, 133.0, 127.0, 120.0, 104.0, 121.0, 121.0, 140.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [139.0, 138.0, 141.0, 140.0, 138.0, 128.0, 143.0, 138.0, 140.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.6}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 64.0, 66.0, 67.0, 67.0, 66.0, 66.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1462.8999999999999}]} 23:14:44 INFO - Return code: 0 23:14:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:14:44 ERROR - # TBPL SUCCESS # 23:14:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:14:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:14:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:14:44 INFO - 2016-04-04 23:14:44.460 screenresolution[1968:14178] starting screenresolution argv=screenresolution get 23:14:44 INFO - 2016-04-04 23:14:44.462 screenresolution[1968:14178] Display 0: 1600x1200x32@60 23:14:44 INFO - 2016-04-04 23:14:44.469 screenresolution[1969:14181] starting screenresolution argv=screenresolution list 23:14:44 INFO - Available Modes on Display 0 23:14:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:14:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:14:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:14:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:14:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:14:44 INFO - Intel Iris: 23:14:44 INFO - Chipset Model: Intel Iris 23:14:44 INFO - Type: GPU 23:14:44 INFO - Bus: Built-In 23:14:44 INFO - VRAM (Dynamic, Max): 1536 MB 23:14:44 INFO - Vendor: Intel (0x8086) 23:14:44 INFO - Device ID: 0x0a2e 23:14:44 INFO - Revision ID: 0x0009 23:14:44 INFO - Displays: 23:14:44 INFO - Display: 23:14:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:14:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:14:44 INFO - Display Serial Number: 1600x1200 60 23:14:44 INFO - Main Display: Yes 23:14:44 INFO - Mirror: Off 23:14:44 INFO - Online: Yes 23:14:44 INFO - Rotation: Supported 23:14:44 INFO - Return code: 0 23:14:44 INFO - Running post-action listener: _resource_record_post_action 23:14:44 INFO - Running post-run listener: _resource_record_post_run 23:14:45 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 557056; Write bytes: 700202496; Read time: 10; Write time: 1787 23:14:45 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 379865600; Write bytes: 372860416; Read time: 28461; Write time: 625 23:14:45 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 544768; Write bytes: 297089024; Read time: 9; Write time: 1101 23:14:45 INFO - Running post-run listener: _upload_blobber_files 23:14:45 INFO - Blob upload gear active. 23:14:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:14:45 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 23:14:45 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'] 23:14:45 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 23:14:46 INFO - (blobuploader) - INFO - Open directory for files ... 23:14:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:14:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:14:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:47 INFO - (blobuploader) - INFO - Done attempting. 23:14:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:14:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:14:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:47 INFO - (blobuploader) - INFO - Done attempting. 23:14:47 INFO - (blobuploader) - INFO - Iteration through files over. 23:14:48 INFO - Return code: 0 23:14:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:14:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:14:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb02e2542b3d525dcc7fa6bf29f5a37250ce1da9c2c479b7bd5bb5b35c3f6198d36b9411f8fdc8aafc3d3f2a92e24d943714bf52f70fe86647d0416ac0360272", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09a11c316d7d393285f1d6ea69d46cfe1a4775f2a98e15b4bbe2d830e2fef0a92e729196b84626b68c9c22db62a8482c733ebc6c1dd0ee45fc43a09660e363a7"} 23:14:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:14:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:14:48 INFO - Contents: 23:14:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb02e2542b3d525dcc7fa6bf29f5a37250ce1da9c2c479b7bd5bb5b35c3f6198d36b9411f8fdc8aafc3d3f2a92e24d943714bf52f70fe86647d0416ac0360272", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09a11c316d7d393285f1d6ea69d46cfe1a4775f2a98e15b4bbe2d830e2fef0a92e729196b84626b68c9c22db62a8482c733ebc6c1dd0ee45fc43a09660e363a7"} 23:14:48 INFO - Running post-run listener: copy_logs_to_upload_dir 23:14:48 INFO - Copying logs to upload dir... 23:14:48 INFO - mkdir: /builds/slave/test/build/upload/logs 23:14:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.139950 ========= master_lag: 0.66 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-04 23:14:48.684448) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 23:14:48.691079) ========= 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.vfKkZZTipb/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.XZIlBypFyR/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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/fb02e2542b3d525dcc7fa6bf29f5a37250ce1da9c2c479b7bd5bb5b35c3f6198d36b9411f8fdc8aafc3d3f2a92e24d943714bf52f70fe86647d0416ac0360272", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09a11c316d7d393285f1d6ea69d46cfe1a4775f2a98e15b4bbe2d830e2fef0a92e729196b84626b68c9c22db62a8482c733ebc6c1dd0ee45fc43a09660e363a7"} build_url:https://queue.taskcluster.net/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011129 build_url: 'https://queue.taskcluster.net/v1/task/W3rqePnhSKGE9c5jN1LuaA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb02e2542b3d525dcc7fa6bf29f5a37250ce1da9c2c479b7bd5bb5b35c3f6198d36b9411f8fdc8aafc3d3f2a92e24d943714bf52f70fe86647d0416ac0360272", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09a11c316d7d393285f1d6ea69d46cfe1a4775f2a98e15b4bbe2d830e2fef0a92e729196b84626b68c9c22db62a8482c733ebc6c1dd0ee45fc43a09660e363a7"}' ========= master_lag: 0.39 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 23:14:49.092517) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 23:14:49.095970) ========= 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.vfKkZZTipb/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.XZIlBypFyR/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005145 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 23:14:49.146392) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 23:14:49.146705) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 23:14:49.160034) ========= ========= Total master_lag: 14.06 =========