builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0143 starttime: 1459362484.5 results: success (0) buildid: 20160330101409 builduid: 97343075228245e6b7bda4b686757b36 revision: e14db462d31d566570e3bece66d5380f7b1ad400 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.498383) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.498910) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.499236) ========= 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.bLHE2rwU7S/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.gqo18YLhoV/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005608 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.524655) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.524994) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.546321) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.546954) ========= 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.bLHE2rwU7S/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.gqo18YLhoV/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005941 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.598419) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.598759) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.599143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.599418) ========= 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.bLHE2rwU7S/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.gqo18YLhoV/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-30 11:28:04-- 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% 49.3M=0s 2016-03-30 11:28:04 (49.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166789 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.784273) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.784794) ========= 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.bLHE2rwU7S/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.gqo18YLhoV/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.026122 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:04.834506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-30 11:28:04.834903) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e14db462d31d566570e3bece66d5380f7b1ad400 --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 e14db462d31d566570e3bece66d5380f7b1ad400 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bLHE2rwU7S/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.gqo18YLhoV/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-30 11:28:04,915 truncating revision to first 12 chars 2016-03-30 11:28:04,915 Setting DEBUG logging. 2016-03-30 11:28:04,915 attempt 1/10 2016-03-30 11:28:04,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e14db462d31d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-30 11:28:06,336 unpacking tar archive at: fx-team-e14db462d31d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.319334 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-30 11:28:07.171985) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:07.172362) ========= echo e14db462d31d566570e3bece66d5380f7b1ad400 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e14db462d31d566570e3bece66d5380f7b1ad400'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bLHE2rwU7S/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.gqo18YLhoV/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 e14db462d31d566570e3bece66d5380f7b1ad400 program finished with exit code 0 elapsedTime=0.005684 script_repo_revision: 'e14db462d31d566570e3bece66d5380f7b1ad400' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:07.221930) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:07.222261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 11:28:07.236370) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-03-30 11:28:07.236773) ========= /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.bLHE2rwU7S/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.gqo18YLhoV/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:28:07 INFO - MultiFileLogger online at 20160330 11:28:07 in /builds/slave/test 11:28:07 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 11:28:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:28:07 INFO - {'append_to_log': False, 11:28:07 INFO - 'base_work_dir': '/builds/slave/test', 11:28:07 INFO - 'blob_upload_branch': 'Fx-Team', 11:28:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:28:07 INFO - 'branch': 'Fx-Team', 11:28:07 INFO - 'buildbot_json_path': 'buildprops.json', 11:28:07 INFO - 'config_files': ('talos/mac_config.py',), 11:28:07 INFO - 'default_actions': ('clobber', 11:28:07 INFO - 'read-buildbot-config', 11:28:07 INFO - 'download-and-extract', 11:28:07 INFO - 'populate-webroot', 11:28:07 INFO - 'create-virtualenv', 11:28:07 INFO - 'install', 11:28:07 INFO - 'run-tests'), 11:28:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:28:07 INFO - 'download_minidump_stackwalk': True, 11:28:07 INFO - 'download_symbols': 'ondemand', 11:28:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:28:07 INFO - 'tooltool.py': '/tools/tooltool.py', 11:28:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:28:07 INFO - '/tools/misc-python/virtualenv.py')}, 11:28:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:28:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:28:07 INFO - 'installer_path': 'installer.exe', 11:28:07 INFO - 'log_level': 'info', 11:28:07 INFO - 'log_name': 'talos', 11:28:07 INFO - 'log_to_console': True, 11:28:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:28:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:28:07 INFO - 'opt_config_files': (), 11:28:07 INFO - 'pip_index': False, 11:28:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:28:07 INFO - 'cmd': ('bash', 11:28:07 INFO - '-c', 11:28:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:28:07 INFO - 'enabled': True, 11:28:07 INFO - 'halt_on_failure': False, 11:28:07 INFO - 'name': 'check_screen_resolution'},), 11:28:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:28:07 INFO - 'cmd': ('bash', 11:28:07 INFO - '-c', 11:28:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:28:07 INFO - 'enabled': True, 11:28:07 INFO - 'halt_on_failure': False, 11:28:07 INFO - 'name': 'check_screen_resolution'},), 11:28:07 INFO - 'run_cmd_checks_enabled': True, 11:28:07 INFO - 'sps_profile': False, 11:28:07 INFO - 'sps_profile_interval': 0, 11:28:07 INFO - 'suite': 'dromaeojs', 11:28:07 INFO - 'system_bits': '32', 11:28:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:28:07 INFO - 'title': 't-yosemite-r7-0143', 11:28:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:28:07 INFO - 'use_talos_json': True, 11:28:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:28:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:28:07 INFO - 'work_dir': 'build'} 11:28:07 INFO - ##### 11:28:07 INFO - ##### Running clobber step. 11:28:07 INFO - ##### 11:28:07 INFO - Running pre-action listener: _resource_record_pre_action 11:28:07 INFO - Running main action method: clobber 11:28:07 INFO - rmtree: /builds/slave/test/build 11:28:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:28:08 INFO - Running post-action listener: _resource_record_post_action 11:28:08 INFO - ##### 11:28:08 INFO - ##### Running read-buildbot-config step. 11:28:08 INFO - ##### 11:28:08 INFO - Running pre-action listener: _resource_record_pre_action 11:28:08 INFO - Running main action method: read_buildbot_config 11:28:08 INFO - Using buildbot properties: 11:28:08 INFO - { 11:28:08 INFO - "project": "", 11:28:08 INFO - "product": "firefox", 11:28:08 INFO - "script_repo_revision": "production", 11:28:08 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:28:08 INFO - "repository": "", 11:28:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:28:08 INFO - "buildid": "20160330101409", 11:28:08 INFO - "pgo_build": "False", 11:28:08 INFO - "basedir": "/builds/slave/test", 11:28:08 INFO - "buildnumber": 587, 11:28:08 INFO - "slavename": "t-yosemite-r7-0143", 11:28:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:28:08 INFO - "platform": "yosemite_r7", 11:28:08 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:28:08 INFO - "branch": "fx-team", 11:28:08 INFO - "repo_path": "integration/fx-team", 11:28:08 INFO - "revision": "e14db462d31d566570e3bece66d5380f7b1ad400", 11:28:08 INFO - "stage_platform": "macosx64", 11:28:08 INFO - "builduid": "97343075228245e6b7bda4b686757b36", 11:28:08 INFO - "slavebuilddir": "test" 11:28:08 INFO - } 11:28:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 11:28:08 INFO - Running post-action listener: _resource_record_post_action 11:28:08 INFO - ##### 11:28:08 INFO - ##### Running download-and-extract step. 11:28:08 INFO - ##### 11:28:08 INFO - Running pre-action listener: _resource_record_pre_action 11:28:08 INFO - Running main action method: download_and_extract 11:28:08 INFO - mkdir: /builds/slave/test/build/tests 11:28:08 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')]} 11:28:08 INFO - https://queue.taskcluster.net/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:28:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:28:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:28:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/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 11:28:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/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 11:28:11 INFO - Downloaded 1199 bytes. 11:28:11 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:28:11 INFO - Using the following test package requirements: 11:28:11 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:28:11 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:28:11 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 11:28:11 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:28:11 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 11:28:11 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:28:11 INFO - u'jsshell-mac.zip'], 11:28:11 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:28:11 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 11:28:11 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:28:11 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:28:11 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 11:28:11 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:28:11 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 11:28:11 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:28:11 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 11:28:11 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:28:11 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 11:28:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:28: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')]} 11:28:11 INFO - https://queue.taskcluster.net/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:28:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:28:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:28:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/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 11:28:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/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 11:28:12 INFO - Downloaded 17946586 bytes. 11:28:12 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'] 11:28:12 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 11:28:15 INFO - Return code: 0 11:28:15 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 11:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:15 INFO - https://queue.taskcluster.net/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:28:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:28:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:28:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/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 11:28:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/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 11:28:21 INFO - Downloaded 17946586 bytes. 11:28:21 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'] 11:28:21 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 11:28:25 INFO - Return code: 0 11:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:25 INFO - https://queue.taskcluster.net/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:28:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:28:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:28:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/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 11:28:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/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 11:28:30 INFO - Downloaded 10847531 bytes. 11:28:30 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'] 11:28:30 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 11:28:30 INFO - Return code: 0 11:28:30 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')]} 11:28:30 INFO - https://queue.taskcluster.net/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:28:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:28:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:28:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 11:28:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EAIxdzxISt2FY5h1T8fkKQ/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 11:28:41 INFO - Downloaded 111429361 bytes. 11:28:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:28:41 INFO - mkdir: /builds/slave/test/properties 11:28:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:28:41 INFO - Writing to file /builds/slave/test/properties/build_url 11:28:41 INFO - Contents: 11:28:41 INFO - build_url:https://queue.taskcluster.net/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:28:43 INFO - Running post-action listener: _resource_record_post_action 11:28:43 INFO - Running post-action listener: set_extra_try_arguments 11:28:43 INFO - ##### 11:28:43 INFO - ##### Running populate-webroot step. 11:28:43 INFO - ##### 11:28:43 INFO - Running pre-action listener: _resource_record_pre_action 11:28:43 INFO - Running main action method: populate_webroot 11:28:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:28:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:28:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:28:43 INFO - '--tppagecycles', 11:28:43 INFO - '7'], 11:28:43 INFO - 'tests': ['tsvgm']}}, 11:28:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:28:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:28:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:28:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:28:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:28:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:28:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:28:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:43 INFO - 'talos_options': ['--e10s'], 11:28:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:28:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:43 INFO - 'tests': ['damp', 'tps']}, 11:28:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:43 INFO - 'talos_options': ['--e10s'], 11:28:43 INFO - 'tests': ['damp', 'tps']}, 11:28:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:28:43 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 11:28:43 INFO - 'tests': ['dromaeo_dom']}, 11:28:43 INFO - 'other': {'tests': ['a11yr', 11:28:43 INFO - 'ts_paint', 11:28:43 INFO - 'tpaint', 11:28:43 INFO - 'sessionrestore', 11:28:43 INFO - 'sessionrestore_no_auto_restore', 11:28:43 INFO - 'tabpaint']}, 11:28:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:28:43 INFO - 'tests': ['a11yr', 11:28:43 INFO - 'ts_paint', 11:28:43 INFO - 'tpaint', 11:28:43 INFO - 'sessionrestore', 11:28:43 INFO - 'sessionrestore_no_auto_restore', 11:28:43 INFO - 'tabpaint']}, 11:28:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:28:43 INFO - 'tests': ['a11yr', 11:28:43 INFO - 'ts_paint', 11:28:43 INFO - 'tpaint', 11:28:43 INFO - 'sessionrestore', 11:28:43 INFO - 'sessionrestore_no_auto_restore', 11:28:43 INFO - 'tabpaint']}, 11:28:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:28:43 INFO - 'tests': ['a11yr', 11:28:43 INFO - 'ts_paint', 11:28:43 INFO - 'tpaint', 11:28:43 INFO - 'sessionrestore', 11:28:43 INFO - 'sessionrestore_no_auto_restore', 11:28:43 INFO - 'tabpaint']}, 11:28:43 INFO - 'other_l64': {'tests': ['a11yr', 11:28:43 INFO - 'ts_paint', 11:28:43 INFO - 'tpaint', 11:28:43 INFO - 'sessionrestore', 11:28:43 INFO - 'sessionrestore_no_auto_restore', 11:28:43 INFO - 'tabpaint']}, 11:28:43 INFO - 'other_nol64': {'tests': ['a11yr', 11:28:43 INFO - 'ts_paint', 11:28:43 INFO - 'tpaint', 11:28:43 INFO - 'sessionrestore', 11:28:43 INFO - 'sessionrestore_no_auto_restore', 11:28:43 INFO - 'tabpaint']}, 11:28:43 INFO - 'svgr': {'tests': ['tsvgx', 11:28:43 INFO - 'tsvgr_opacity', 11:28:43 INFO - 'tart', 11:28:43 INFO - 'tscrollx', 11:28:43 INFO - 'cart']}, 11:28:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:28:43 INFO - 'tests': ['tsvgx', 11:28:43 INFO - 'tsvgr_opacity', 11:28:43 INFO - 'tart', 11:28:43 INFO - 'tscrollx', 11:28:43 INFO - 'cart']}, 11:28:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:43 INFO - 'tests': ['tp5o']}, 11:28:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:43 INFO - 'talos_options': ['--e10s'], 11:28:43 INFO - 'tests': ['tp5o']}, 11:28:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:43 INFO - 'talos_options': ['--xperf_path', 11:28:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:28:43 INFO - 'tests': ['tp5n']}, 11:28:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:28:43 INFO - 'talos_options': ['--e10s', 11:28:43 INFO - '--xperf_path', 11:28:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:28:43 INFO - 'tests': ['tp5n']}}, 11:28:43 INFO - 'talos.zip': {'path': '', 11:28:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:28:43 INFO - Running post-action listener: _resource_record_post_action 11:28:43 INFO - ##### 11:28:43 INFO - ##### Running create-virtualenv step. 11:28:43 INFO - ##### 11:28:43 INFO - Running pre-action listener: _resource_record_pre_action 11:28:43 INFO - Running main action method: create_virtualenv 11:28:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:28:43 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 11:28:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:28:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:28:43 INFO - Using real prefix '/tools/python27' 11:28:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:28:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:28:47 INFO - Installing pip.................done. 11:28:47 INFO - Return code: 0 11:28:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10953aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb40cc8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093d9e00>, '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 0x109202db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093d4b20>, '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.bLHE2rwU7S/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.gqo18YLhoV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:28:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bLHE2rwU7S/Render', 11:28:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:28:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:28:47 INFO - 'HOME': '/Users/cltbld', 11:28:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:28:47 INFO - 'LOGNAME': 'cltbld', 11:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:47 INFO - 'MOZ_NO_REMOTE': '1', 11:28:47 INFO - 'NO_EM_RESTART': '1', 11:28:47 INFO - 'PAGER': '/bin/cat', 11:28:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:47 INFO - 'PWD': '/builds/slave/test', 11:28:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:28:47 INFO - 'SHELL': '/bin/bash', 11:28:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gqo18YLhoV/Listeners', 11:28:47 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:28:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:28:47 INFO - 'USER': 'cltbld', 11:28:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:28:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:47 INFO - 'XPC_FLAGS': '0x0', 11:28:47 INFO - 'XPC_SERVICE_NAME': '0', 11:28:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:47 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 11:28:47 INFO - Cleaning up... 11:28:47 INFO - Return code: 0 11:28:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10953aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb40cc8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093d9e00>, '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 0x109202db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093d4b20>, '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.bLHE2rwU7S/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.gqo18YLhoV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:28:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bLHE2rwU7S/Render', 11:28:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:28:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:28:47 INFO - 'HOME': '/Users/cltbld', 11:28:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:28:47 INFO - 'LOGNAME': 'cltbld', 11:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:47 INFO - 'MOZ_NO_REMOTE': '1', 11:28:47 INFO - 'NO_EM_RESTART': '1', 11:28:47 INFO - 'PAGER': '/bin/cat', 11:28:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:47 INFO - 'PWD': '/builds/slave/test', 11:28:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:28:47 INFO - 'SHELL': '/bin/bash', 11:28:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gqo18YLhoV/Listeners', 11:28:47 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:28:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:28:47 INFO - 'USER': 'cltbld', 11:28:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:28:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:47 INFO - 'XPC_FLAGS': '0x0', 11:28:47 INFO - 'XPC_SERVICE_NAME': '0', 11:28:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:47 INFO - Downloading/unpacking psutil>=0.7.1 11:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:28:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:28:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:28:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:28:51 INFO - Installing collected packages: psutil 11:28:51 INFO - Running setup.py install for psutil 11:28:51 INFO - building 'psutil._psutil_osx' extension 11:28:51 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 11:28:51 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 11:28:52 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 11:28:52 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 11:28:52 INFO - building 'psutil._psutil_posix' extension 11:28:52 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 11:28:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:28:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:28:52 INFO - ^ 11:28:52 INFO - 1 warning generated. 11:28:52 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 11:28:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:28:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:28:52 INFO - Successfully installed psutil 11:28:52 INFO - Cleaning up... 11:28:52 INFO - Return code: 0 11:28:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:28: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')]} 11:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28: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')]} 11:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:52 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 0x10953aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb40cc8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093d9e00>, '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 0x109202db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093d4b20>, '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.bLHE2rwU7S/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.gqo18YLhoV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:28:52 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 11:28:52 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 11:28:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bLHE2rwU7S/Render', 11:28:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:28:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:28:52 INFO - 'HOME': '/Users/cltbld', 11:28:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:28:52 INFO - 'LOGNAME': 'cltbld', 11:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:52 INFO - 'MOZ_NO_REMOTE': '1', 11:28:52 INFO - 'NO_EM_RESTART': '1', 11:28:52 INFO - 'PAGER': '/bin/cat', 11:28:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:52 INFO - 'PWD': '/builds/slave/test', 11:28:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:28:52 INFO - 'SHELL': '/bin/bash', 11:28:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gqo18YLhoV/Listeners', 11:28:52 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:28:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:28:52 INFO - 'USER': 'cltbld', 11:28:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:28:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:52 INFO - 'XPC_FLAGS': '0x0', 11:28:52 INFO - 'XPC_SERVICE_NAME': '0', 11:28:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:28:56 INFO - Installing collected packages: mozsystemmonitor 11:28:56 INFO - Running setup.py install for mozsystemmonitor 11:28:56 INFO - Successfully installed mozsystemmonitor 11:28:56 INFO - Cleaning up... 11:28:56 INFO - Return code: 0 11:28:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:28:56 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')]} 11:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:56 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')]} 11:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:28:56 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 0x10953aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb40cc8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093d9e00>, '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 0x109202db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093d4b20>, '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.bLHE2rwU7S/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.gqo18YLhoV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:28:56 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 11:28:56 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 11:28:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bLHE2rwU7S/Render', 11:28:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:28:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:28:56 INFO - 'HOME': '/Users/cltbld', 11:28:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:28:56 INFO - 'LOGNAME': 'cltbld', 11:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:56 INFO - 'MOZ_NO_REMOTE': '1', 11:28:56 INFO - 'NO_EM_RESTART': '1', 11:28:56 INFO - 'PAGER': '/bin/cat', 11:28:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:56 INFO - 'PWD': '/builds/slave/test', 11:28:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:28:56 INFO - 'SHELL': '/bin/bash', 11:28:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gqo18YLhoV/Listeners', 11:28:56 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:28:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:28:56 INFO - 'USER': 'cltbld', 11:28:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:28:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:56 INFO - 'XPC_FLAGS': '0x0', 11:28:56 INFO - 'XPC_SERVICE_NAME': '0', 11:28:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:28:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:59 INFO - Downloading blobuploader-1.2.4.tar.gz 11:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:28:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:28:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:29:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:00 INFO - Downloading docopt-0.6.1.tar.gz 11:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:29:00 INFO - Installing collected packages: blobuploader, requests, docopt 11:29:00 INFO - Running setup.py install for blobuploader 11:29:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:29:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:29:01 INFO - Running setup.py install for requests 11:29:01 INFO - Running setup.py install for docopt 11:29:01 INFO - Successfully installed blobuploader requests docopt 11:29:01 INFO - Cleaning up... 11:29:01 INFO - Return code: 0 11:29:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:02 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')]} 11:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:02 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 0x10953aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb40cc8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093d9e00>, '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 0x109202db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093d4b20>, '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.bLHE2rwU7S/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.gqo18YLhoV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:29:02 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 11:29:02 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 11:29:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bLHE2rwU7S/Render', 11:29:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:29:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:29:02 INFO - 'HOME': '/Users/cltbld', 11:29:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:29:02 INFO - 'LOGNAME': 'cltbld', 11:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:02 INFO - 'MOZ_NO_REMOTE': '1', 11:29:02 INFO - 'NO_EM_RESTART': '1', 11:29:02 INFO - 'PAGER': '/bin/cat', 11:29:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:02 INFO - 'PWD': '/builds/slave/test', 11:29:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:29:02 INFO - 'SHELL': '/bin/bash', 11:29:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gqo18YLhoV/Listeners', 11:29:02 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:29:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:29:02 INFO - 'USER': 'cltbld', 11:29:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:29:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:02 INFO - 'XPC_FLAGS': '0x0', 11:29:02 INFO - 'XPC_SERVICE_NAME': '0', 11:29:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:29:02 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-mn0jKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:29:02 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-kdpFmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:29:02 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Aoxhf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:29:02 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-RbXC0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:29:02 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-_WFv_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:29:02 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-LE1JdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:29:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-4V0Bsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:29:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-3cN8GC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:29:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Kt0W0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:29:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-bmOHti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:29:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-6_rrov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:29:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-5sef3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:29:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-mbrcxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:29:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-tRQydm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-tF4WWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:29:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-BdJW8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:29:04 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-mGX7B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:29:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:29:04 INFO - Running setup.py install for manifestparser 11:29:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:29:04 INFO - Running setup.py install for mozcrash 11:29:04 INFO - Running setup.py install for mozdebug 11:29:04 INFO - Running setup.py install for mozdevice 11:29:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:29:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:29:04 INFO - Running setup.py install for mozfile 11:29:04 INFO - Running setup.py install for mozhttpd 11:29:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:29:05 INFO - Running setup.py install for mozinfo 11:29:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:29:05 INFO - Running setup.py install for mozInstall 11:29:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:29:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:29:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:29:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:29:05 INFO - Running setup.py install for mozleak 11:29:05 INFO - Running setup.py install for mozlog 11:29:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:29:05 INFO - Running setup.py install for moznetwork 11:29:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:29:05 INFO - Running setup.py install for mozprocess 11:29:05 INFO - Running setup.py install for mozprofile 11:29:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:29:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:29:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:29:06 INFO - Running setup.py install for mozrunner 11:29:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:29:06 INFO - Running setup.py install for mozscreenshot 11:29:06 INFO - Running setup.py install for moztest 11:29:06 INFO - Running setup.py install for mozversion 11:29:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:29:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:29:06 INFO - Cleaning up... 11:29:06 INFO - Return code: 0 11:29:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:29: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')]} 11:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29: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')]} 11:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:06 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 0x10953aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb40cc8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093d9e00>, '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 0x109202db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093d4b20>, '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.bLHE2rwU7S/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.gqo18YLhoV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:29:06 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 11:29:06 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 11:29:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bLHE2rwU7S/Render', 11:29:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:29:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:29:06 INFO - 'HOME': '/Users/cltbld', 11:29:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:29:06 INFO - 'LOGNAME': 'cltbld', 11:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:06 INFO - 'MOZ_NO_REMOTE': '1', 11:29:06 INFO - 'NO_EM_RESTART': '1', 11:29:06 INFO - 'PAGER': '/bin/cat', 11:29:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:06 INFO - 'PWD': '/builds/slave/test', 11:29:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:29:06 INFO - 'SHELL': '/bin/bash', 11:29:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gqo18YLhoV/Listeners', 11:29:06 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:29:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:29:06 INFO - 'USER': 'cltbld', 11:29:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:29:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:06 INFO - 'XPC_FLAGS': '0x0', 11:29:06 INFO - 'XPC_SERVICE_NAME': '0', 11:29:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:29:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-23px39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:29:07 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)) 11:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:29:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-33rWMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:29:07 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)) 11:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:29:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-UfKCHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:29:07 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)) 11:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:29:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-AUFJ2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:29:07 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)) 11:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:29:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-3SsW7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:29:07 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)) 11:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:29:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ViNRVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:29:07 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)) 11:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:29:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-hLhVOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:29:07 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)) 11:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:29:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-4OPeHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:29:07 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)) 11:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:29:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-_6iMLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:29:07 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)) 11:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:29:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-0GvZ6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:29:08 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)) 11:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:29:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-zpz6Xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:29:08 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)) 11:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:29:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-zL2b9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:29:08 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)) 11:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:29:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-V5WFsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:29:08 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)) 11:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:29:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-oTuN2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:29:08 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)) 11:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-pCNE5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:08 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)) 11:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:29:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-2zvFKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:29:08 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)) 11:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:29:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-QNM5Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:29:08 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)) 11:29:08 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)) 11:29:08 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)) 11:29:08 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)) 11:29:08 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)) 11:29:08 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)) 11:29:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:29:08 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 11:29:08 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 11:29:08 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 11:29:08 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 11:29:08 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 11:29:08 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 11:29:11 INFO - Downloading blessings-1.6.tar.gz 11:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:29:12 INFO - Installing collected packages: blessings 11:29:12 INFO - Running setup.py install for blessings 11:29:12 INFO - Successfully installed blessings 11:29:12 INFO - Cleaning up... 11:29:12 INFO - Return code: 0 11:29:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:29:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:29:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:29:12 INFO - Reading from file tmpfile_stdout 11:29:12 INFO - Current package versions: 11:29:12 INFO - blessings == 1.6 11:29:12 INFO - blobuploader == 1.2.4 11:29:12 INFO - docopt == 0.6.1 11:29:12 INFO - manifestparser == 1.1 11:29:12 INFO - mozInstall == 1.12 11:29:12 INFO - mozcrash == 0.17 11:29:12 INFO - mozdebug == 0.1 11:29:12 INFO - mozdevice == 0.48 11:29:12 INFO - mozfile == 1.2 11:29:12 INFO - mozhttpd == 0.7 11:29:12 INFO - mozinfo == 0.9 11:29:12 INFO - mozleak == 0.1 11:29:12 INFO - mozlog == 3.1 11:29:12 INFO - moznetwork == 0.27 11:29:12 INFO - mozprocess == 0.22 11:29:12 INFO - mozprofile == 0.28 11:29:12 INFO - mozrunner == 6.11 11:29:12 INFO - mozscreenshot == 0.1 11:29:12 INFO - mozsystemmonitor == 0.0 11:29:12 INFO - moztest == 0.7 11:29:12 INFO - mozversion == 1.4 11:29:12 INFO - psutil == 3.1.1 11:29:12 INFO - requests == 1.2.3 11:29:12 INFO - wsgiref == 0.1.2 11:29:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:12 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 0x10953aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb40cc8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093d9e00>, '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 0x109202db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093d4b20>, '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.bLHE2rwU7S/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.gqo18YLhoV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:29:12 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 11:29:12 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 11:29:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bLHE2rwU7S/Render', 11:29:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:29:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:29:12 INFO - 'HOME': '/Users/cltbld', 11:29:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:29:12 INFO - 'LOGNAME': 'cltbld', 11:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:12 INFO - 'MOZ_NO_REMOTE': '1', 11:29:12 INFO - 'NO_EM_RESTART': '1', 11:29:12 INFO - 'PAGER': '/bin/cat', 11:29:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:12 INFO - 'PWD': '/builds/slave/test', 11:29:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:29:12 INFO - 'SHELL': '/bin/bash', 11:29:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gqo18YLhoV/Listeners', 11:29:12 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:29:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:29:12 INFO - 'USER': 'cltbld', 11:29:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:29:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:12 INFO - 'XPC_FLAGS': '0x0', 11:29:12 INFO - 'XPC_SERVICE_NAME': '0', 11:29:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:12 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)) 11:29:12 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)) 11:29:12 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)) 11:29:12 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)) 11:29:12 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)) 11:29:12 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)) 11:29:12 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)) 11:29:12 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)) 11:29:12 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)) 11:29:12 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)) 11:29:12 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)) 11:29:12 INFO - Cleaning up... 11:29:12 INFO - Return code: 0 11:29:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:12 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 0x10953aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb40cc8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093d9e00>, '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 0x109202db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093d4b20>, '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.bLHE2rwU7S/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.gqo18YLhoV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:29:12 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 11:29:12 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 11:29:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bLHE2rwU7S/Render', 11:29:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:29:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:29:12 INFO - 'HOME': '/Users/cltbld', 11:29:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:29:12 INFO - 'LOGNAME': 'cltbld', 11:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:12 INFO - 'MOZ_NO_REMOTE': '1', 11:29:12 INFO - 'NO_EM_RESTART': '1', 11:29:12 INFO - 'PAGER': '/bin/cat', 11:29:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:12 INFO - 'PWD': '/builds/slave/test', 11:29:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:29:12 INFO - 'SHELL': '/bin/bash', 11:29:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gqo18YLhoV/Listeners', 11:29:12 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:29:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:29:12 INFO - 'USER': 'cltbld', 11:29:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:29:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:12 INFO - 'XPC_FLAGS': '0x0', 11:29:12 INFO - 'XPC_SERVICE_NAME': '0', 11:29:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:13 INFO - Downloading/unpacking jsonschema 11:29:13 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 11:29:13 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 11:29:13 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 11:29:13 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 11:29:13 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 11:29:13 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 11:29:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:29:15 INFO - Downloading/unpacking functools32 (from jsonschema) 11:29: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 11:29: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 11:29: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 11:29: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 11:29: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 11:29: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 11:29:16 INFO - Downloading functools32-3.2.3-2.tar.gz 11:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:29:16 INFO - warning: no files found matching '*.txt' 11:29:16 INFO - no previously-included directories found matching 'build' 11:29:16 INFO - no previously-included directories found matching 'dist' 11:29:16 INFO - no previously-included directories found matching '.git*' 11:29:16 INFO - Installing collected packages: jsonschema, functools32 11:29:16 INFO - Running setup.py install for functools32 11:29:16 INFO - warning: no files found matching '*.txt' 11:29:16 INFO - no previously-included directories found matching 'build' 11:29:16 INFO - no previously-included directories found matching 'dist' 11:29:16 INFO - no previously-included directories found matching '.git*' 11:29:16 INFO - Successfully installed jsonschema functools32 11:29:16 INFO - Cleaning up... 11:29:16 INFO - Return code: 0 11:29:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:16 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 0x10953aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb40cc8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093d9e00>, '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 0x109202db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093d4b20>, '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.bLHE2rwU7S/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.gqo18YLhoV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:29:16 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 11:29:16 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 11:29:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bLHE2rwU7S/Render', 11:29:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:29:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:29:16 INFO - 'HOME': '/Users/cltbld', 11:29:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:29:16 INFO - 'LOGNAME': 'cltbld', 11:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:16 INFO - 'MOZ_NO_REMOTE': '1', 11:29:16 INFO - 'NO_EM_RESTART': '1', 11:29:16 INFO - 'PAGER': '/bin/cat', 11:29:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:16 INFO - 'PWD': '/builds/slave/test', 11:29:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:29:16 INFO - 'SHELL': '/bin/bash', 11:29:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gqo18YLhoV/Listeners', 11:29:16 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:29:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:29:16 INFO - 'USER': 'cltbld', 11:29:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:29:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:16 INFO - 'XPC_FLAGS': '0x0', 11:29:16 INFO - 'XPC_SERVICE_NAME': '0', 11:29:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:16 INFO - Downloading/unpacking flake8 11:29:16 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 11:29:16 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 11:29:16 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 11:29:16 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 11:29:16 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 11:29:16 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 11:29:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:29:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:29:19 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 11:29:19 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 11:29:19 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 11:29:19 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 11:29:19 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 11:29:19 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 11:29:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:29:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:29:19 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 11:29:19 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 11:29:19 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 11:29:19 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 11:29:19 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 11:29:19 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 11:29:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:29:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:29:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:29:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:29:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:29:20 INFO - no previously-included directories found matching 'docs/_build' 11:29:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:29:20 INFO - Running setup.py install for pep8 11:29:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:29:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:29:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:29:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:29:20 INFO - no previously-included directories found matching 'docs/_build' 11:29:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:29:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:29:21 INFO - Cleaning up... 11:29:21 INFO - Return code: 0 11:29:21 INFO - Running post-action listener: _resource_record_post_action 11:29:21 INFO - Running post-action listener: _start_resource_monitoring 11:29:21 INFO - Starting resource monitoring. 11:29:21 INFO - ##### 11:29:21 INFO - ##### Running install step. 11:29:21 INFO - ##### 11:29:21 INFO - Running pre-action listener: _resource_record_pre_action 11:29:21 INFO - Running main action method: install 11:29:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:29:21 INFO - Reading from file tmpfile_stdout 11:29:21 INFO - Detecting whether we're running mozinstall >=1.0... 11:29:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:29:21 INFO - Reading from file tmpfile_stdout 11:29:21 INFO - Output received: 11:29:21 INFO - Usage: mozinstall [options] installer 11:29:21 INFO - Options: 11:29:21 INFO - -h, --help show this help message and exit 11:29:21 INFO - -d DEST, --destination=DEST 11:29:21 INFO - Directory to install application into. [default: 11:29:21 INFO - "/builds/slave/test"] 11:29:21 INFO - --app=APP Application being installed. [default: firefox] 11:29:21 INFO - mkdir: /builds/slave/test/build/application 11:29:21 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'] 11:29:21 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 11:29:55 INFO - Reading from file tmpfile_stdout 11:29:55 INFO - Output received: 11:29:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:29:55 INFO - Running post-action listener: _resource_record_post_action 11:29:55 INFO - ##### 11:29:55 INFO - ##### Running run-tests step. 11:29:55 INFO - ##### 11:29:55 INFO - Running pre-action listener: _resource_record_pre_action 11:29:55 INFO - Running main action method: run_tests 11:29:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:29:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:29:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:29:55 INFO - 2016-03-30 11:29:55.987 screenresolution[1645:7724] starting screenresolution argv=screenresolution get 11:29:55 INFO - 2016-03-30 11:29:55.990 screenresolution[1645:7724] Display 0: 1600x1200x32@60 11:29:55 INFO - 2016-03-30 11:29:55.997 screenresolution[1646:7726] starting screenresolution argv=screenresolution list 11:29:55 INFO - Available Modes on Display 0 11:29:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:29:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:29:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:29:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:29:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:29:56 INFO - Intel Iris: 11:29:56 INFO - Chipset Model: Intel Iris 11:29:56 INFO - Type: GPU 11:29:56 INFO - Bus: Built-In 11:29:56 INFO - VRAM (Dynamic, Max): 1536 MB 11:29:56 INFO - Vendor: Intel (0x8086) 11:29:56 INFO - Device ID: 0x0a2e 11:29:56 INFO - Revision ID: 0x0009 11:29:56 INFO - Displays: 11:29:56 INFO - Display: 11:29:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:29:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:29:56 INFO - Display Serial Number: 1600x1200 60 11:29:56 INFO - Main Display: Yes 11:29:56 INFO - Mirror: Off 11:29:56 INFO - Online: Yes 11:29:56 INFO - Rotation: Supported 11:29:56 INFO - Return code: 0 11:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:29:56 INFO - Python 2.7.3 11:29:56 INFO - Return code: 0 11:29:56 INFO - grabbing minidump binary from tooltool 11:29:56 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')]} 11:29:56 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 0x1093d9e00>, '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 0x109202db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093d4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:29:56 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 11:29:56 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 11:29:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:29:56 INFO - Return code: 0 11:29:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:29:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:29:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:29:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:29:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:29:57 INFO - Return code: 0 11:29:57 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/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 11:29:57 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/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0143 --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 11:29:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bLHE2rwU7S/Render', 11:29:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:29:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:29:57 INFO - 'HOME': '/Users/cltbld', 11:29:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:29:57 INFO - 'LOGNAME': 'cltbld', 11:29:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:29:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:57 INFO - 'MOZ_NO_REMOTE': '1', 11:29:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:29:57 INFO - 'NO_EM_RESTART': '1', 11:29:57 INFO - 'PAGER': '/bin/cat', 11:29:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:57 INFO - 'PWD': '/builds/slave/test', 11:29:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:29:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:29:57 INFO - 'SHELL': '/bin/bash', 11:29:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gqo18YLhoV/Listeners', 11:29:57 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:29:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:29:57 INFO - 'USER': 'cltbld', 11:29:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:29:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:57 INFO - 'XPC_FLAGS': '0x0', 11:29:57 INFO - 'XPC_SERVICE_NAME': '0', 11:29:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:29:57 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/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 11:29:57 INFO - mozversion application_buildid: 20160330101409 11:29:57 INFO - mozversion application_changeset: e14db462d31d566570e3bece66d5380f7b1ad400 11:29:57 INFO - mozversion application_display_name: Nightly 11:29:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:29:57 INFO - mozversion application_name: Firefox 11:29:57 INFO - mozversion application_remotingname: firefox 11:29:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:29:57 INFO - mozversion application_vendor: Mozilla 11:29:57 INFO - mozversion application_version: 48.0a1 11:29:57 INFO - mozversion platform_buildid: 20160330101409 11:29:57 INFO - mozversion platform_changeset: e14db462d31d566570e3bece66d5380f7b1ad400 11:29:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:29:57 INFO - mozversion platform_version: 48.0a1 11:29:57 INFO - using testdate: 1459362597 11:29:57 INFO - actual date: 1459362597 11:29:57 INFO - starting webserver on 'localhost:49271' 11:29:57 INFO - SUITE-START | Running 2 tests 11:29:57 INFO - TEST-START | dromaeo_css 11:29:57 INFO - operating with platform_type : mac_ 11:29:57 INFO - Initialising browser for dromaeo_css test... 11:29:57 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpJCIE9n/profile http://localhost:49271/getInfo.html) 11:30:00 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 11:30:00 INFO - PROCESS | 1664 | colorDepth:24 11:30:00 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 11:30:00 INFO - PROCESS | 1664 | __metrics 11:30:00 INFO - PROCESS | 1664 | 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" 11:30:00 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:30:00 INFO - TEST-INFO | 1664: exit 0 11:30:00 INFO - Browser initialized. 11:30:00 INFO - Running cycle 1/1 for dromaeo_css test... 11:30:00 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpJCIE9n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:30:12 INFO - PROCESS | 1668 | RSS: Main: 244596736 11:30:12 INFO - PROCESS | 1668 | 11:31:03 INFO - PROCESS | 1668 | 1459362663614 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] 11:33:13 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 11:33:15 INFO - PROCESS | 1668 | RSS: Main: 338927616 11:33:15 INFO - PROCESS | 1668 | 11:36:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 11:36:18 INFO - PROCESS | 1668 | RSS: Main: 374910976 11:36:18 INFO - PROCESS | 1668 | 11:39:20 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 11:39:20 INFO - PROCESS | 1668 | RSS: Main: 375349248 11:39:20 INFO - PROCESS | 1668 | 11:42:22 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 11:42:23 INFO - PROCESS | 1668 | RSS: Main: 335790080 11:42:23 INFO - PROCESS | 1668 | 11:45:26 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 11:45:26 INFO - PROCESS | 1668 | RSS: Main: 337690624 11:45:26 INFO - PROCESS | 1668 | 11:48:29 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 11:48:29 INFO - PROCESS | 1668 | RSS: Main: 445956096 11:48:29 INFO - PROCESS | 1668 | 11:48:29 INFO - PROCESS | 1668 | __start_tp_report 11:48:29 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 11:48:29 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 11:48:29 INFO - PROCESS | 1668 | |i|pagename|runs| 11:48:29 INFO - PROCESS | 1668 | |0;dojo.html;3220.484722444409;3464.0127563644364;3497.300539892019;3500.7724497907643;3551.4140166872467;4597.563231493007;5476.3702174249975;5588.972055139729;5653.717314134292;5667.0932650775885;5628.493435590796;5636.830895073144;5648.74580643871;5778.133280008001;5792.6814025228705;5018.397792264915;5039.09296326661;5075.771590278447;5084.1611134163;5196.020831881145;5225.425203227642;5249.606279529032;5260.631755777097;5276.525112739852;5284.2073688946775;5023.120953833083;5038.2190760432195;5124.103281925648;5159.974200129013;5204.895902081975;5006.6245031622775;5015.724135172564;5018.096742586333;5031.52200540948;5052.7726252318735;4947.851564453073;4977.676451030671;4984.2025275955675;5001.9749901250625;5007.399112106534;5147.588192944556;5454.263674403984;5504.614676972614;5621.409751976024;5695.544356451515;5749.482546570829;6167.074938759222;6170.876582468325;6175.96912015437;6187.226596675416;6209;6262.968685156545;6268;6274.466670333027;6288.9056664150075;5645.915311270334;5735.999999999958;5754.654720716729;5854.795082172103;5922.022866227025;6205.844853878689;6216.222972128484;6229.719662615194;6237.376262373817;6247.250329960434;6044.093385992049;6060.545459090586;6109.633421994695;6116.082587611805;6119.5104391648565;6032.577719559588;6108.37242585679;6134.252905685651;6227.252729672468;6234.314225435199;6122.816315510542;6145.231846019247;6146.293176284785;6152.600080994721;6169.691515424301;6182.474489668339;6186.381361863868;6203.937960620336;6205.007198848162;6206.72069756862;4731.361266229015;4834.927476087792;4865.440474345495;4865.756712164378;4870.439899411542;3768.2840260350445;4426.601605855489;4441.822327106879;4471.99380139466;4487.214737420938;5609.214709940612;5636.774529018875;5721.8569535761935;5740.39725828782;5752.108423194411;6201.224846894138;6213.937860621426;6224.37756224383;6228.128062071313;6230.56386052981;5603.887922241533;5727.570432217601;5732.226149469851;5747.195392645033;5820;5313.760880760375;5319.760610772524;5365.865853353619;5400.000999814968;5409.7295135243085;6251.6561589113035;6260.060990851409;6280.434760871543;6281.59169653971;6286.654234017082;6107.969460152671;6118.816435506942;6221.813345599639;6252.9062064069985;6253.405926436982;6163.322034576104;6222.315545289924;6252.5935814171935;6296.716647750954;6305.842353941188;6144.047672610753;6159.19930409044;6174.043023331391;6175.505959523317;6176;6124.234470691164;6236.532260080421;6240.095186198067;6250.312465628868;6267.561270711189;6014.127951446928;6038.849028774316;6100.944524685144;6120.17287048654;6133.969330153321;4279.636230920407;5263.868403289948;5718.228039214653;6039.456448919618;6109.236345456818;5776.682282474504;5895.4399332063385;5924.585279030426;5928.318243402064;5950.404959504015;6006.129111278753;6009.429104235265;6098.542609304409;6125.890594128479;6139.982816839612;5916.201312822886;5920.319163296276;5924.526037917042;5935.228420305505;5965.642061476326 11:48:29 INFO - PROCESS | 1668 | |1;ext.html;487.9146149423854;577.59279707806;589.1692713274282;628.2084573437469;640.1901594482979;38277.61722382775;38762;38783.80608096955;38833;38842.80578597107;41625;41920.74237772872;42061.36907946383;42151;42171.78914105425;9401.435913845156;9631.518424078804;9631.614735410576;9634.56644450998;9641.61433542661;9446.622135114587;9577.329586928918;9586.808263834719;9604.183644390236;9614.903850961506;9669;9739.853902191473;9740.561674724619;9759.316847820655;9766.072223138826;8974.596143173572;9087.182563487297;9622.422654640708;9725;9734.41593504385;9509.762255943588;9649.228061755042;9653.71038868835;9657.130858222723;9663;39835.00412489682;40228;40277.39583906244;40378.19243615111;40392.99017524556;3127.0462508934766;3237.4496335623003;3268.215628249227;3695.3533131701843;4131.648809851166;28046;28141.015064472645;28615.14154575366;28643;28832.990845320313;2519.3071905226025;2527.140772137482;2540.618907163922;2588.6505321781506;2684.979707711077;429236.99999999686;432607;436286;436421;436812.8159359183;42841.78579107085;46515.30227046597;46530.76734616373;55901.322960311256;61682.69158654178;45689;45747.542524574994;45936.8515787108;46064;46116.847078823295;15834.92082539603;15999.520014399586;15999.760003599955;16001.79986501017;16006.919965400099;12800.167989080866;12851.807222891664;12880.871191288155;12895.097343185887;12933.482660693655;14797.112173269637;14862.405503779728;14878.925605371904;14889.851101489063;15001;6190.81427557174;6293.905591416133;6329.493640508748;6340.809775706736;6356.300806911236;966.5984322732066;967.8064387122604;1001.5342865567401;1006.2654262388497;1034.736142283728;28714.712852871206;29160.416791664473;29328.560071598942;29375;29375.85312073426;1106.8505751723576;1117.2961034548182;1120.9775804483866;1198.3049831097942;1212.3089838791805;11709.707257318465;14396.712065758626;14545.490907818175;14963.700725985636;15074.0201886877;429422;509849.45075274387;516104;516524;518506;42258.15483690309;58150.836983260946;58467.415325846196;58517.41482585205;61168;1311.4623004568082;1447.2835946206694;1456.6285597172653;1477;1490.567735356756;27983.30041748891;28090.2977425566;28403.573946391232;28631.14106576806;28730.569041463976;44324.11351773011;44756.77621611871;44832;44869.55130448654;44897.32654010127;267930;304817;305233;305352;305506;27963.44073118567;32006.51990220102;32166.678333217304;32506;32748.83625581857;40217.59782402139;40668;41833.372499411926;42029;42171.57828421799;32922.34155316928;34402.48396274108;34490;35169.82415087908;35194;26151.869240653676;33995.3200935975;34914;35500.46749298711;35681.46477802783;35981.64018359783;36240.09399765027;36298;37124.81437592795;37976.24047519089;30062.849685751433;31300.686993130686;31326.903558375347;31382.686173137976;31796.841015794773;23587.287461942095;24286.63570046486;24303.75696243015;24464.51070978606;24536.178339491187 11:48:29 INFO - PROCESS | 1668 | |2;jquery.html;361.7088243963609;364.8668236093825;368.16243047067917;375.0492501508676;376.24750499001993;19324.454043676506;19537.609247815035;20198.596028079428;20233.696494552594;20646.690299645517;10728.624498142566;12247.755044899097;12247.938760306208;12253.019758419327;12258.816117758219;4643.164230438537;4654.8595594079325;4889.877753056176;4900.191468407708;5277.261183434322;5221.947780522184;5250.684958902478;5280.260763493114;5283.682979021271;5296.523312901838;5156.458571849939;5270.683758974474;5271.630985830993;5278.894422111555;5749.453801888835;5693.032184528619;5727.083666613322;5757.366689664133;5761.366249712528;5772.09520858118;5073.771680274396;5084.44071152173;5086.03365360584;5088.262201980692;5342.759575819097;12974.221546707133;13317.134386264861;13354.26551539665;13366;13372.197668139943;2019.7273368095414;2168.6313326734494;2179.2263746370127;2187.7921597448217;2587.896484140651;9344.719658410258;9895.01049895012;10050.195984321237;12830.90937270333;13852.861471385359;1678.8992660440413;1733.7746093007954;1772.3765011424255;1777.4223377402395;1813.954651133719;87333.68999465014;87446.56276718639;88016.99999999936;96988.03011969861;101328;10962.123030157569;11186.384748838893;11362.091032717362;11482.598109066143;11635.243709158878;13802.37889294984;13844;13862.861371386158;13891.097078690054;13891.583252502442;8351.1648835116;8498.49009059446;8521.659133634585;8570.528620925785;8632.395732298679;8596.183362580545;8603.01065377477;8633.438826476258;8711.477311361212;8713.477191368538;4344.152890186447;4438.955610443919;4468.865934021985;4473.753943533072;4474.597286244189;1807.1777341309673;1862.6274745050773;1865.1420346640425;1875.6717574424695;1894.4506093232808;900.3382513852313;921.15714121578;995.2883688162998;1008.4604736465956;1017.954192061359;18391.356302529348;19082.14130364137;19540.51148721265;19957.900210498854;20014.235442269528;906.4470672889532;932.6129656192604;951.8477043673117;970.5147426286857;982.4940155819759;9987.750306242257;10287.434191119411;10290.279680422449;10325.122364599094;10470.895291046992;493090;503435;503616;547504;605970;69928.60142797115;94005;112494.31258531129;121749.17376239364;122091.38954305172;1034.9482525873675;1055.883852776194;1082.4587706146926;1131.4060118437721;1134.0643968725835;13938.233397163254;17338.73991890148;17511.912440437718;17866.821331786516;18184.909075455067;46256.768716156206;50389;50878.98242035213;50969.999999998516;52635.73682131565;65277.67361163354;72626.63686681533;72635.63682181555;72854;73343.53312933605;7462.589557574169;7786.961065194638;7866.134725180111;7898.170692077479;8083.2725054743005;11705.414729263332;12339.197952133083;12511.874881251435;12613.810792838298;12777.93611031939;9958.804943406838;9964.850527242243;9976.90254072066;10122.59509619607;10794.838077429002;10730.302530335503;10772.299800512941;10817;11114.555417783198;11185.496652650812;10783.676489705322;11058.22592418523;11385.943070284928;11398.658040258806;11469.598564050219;7702.768916932501;7704.30661240491;7811.336036436966;7857.174996625272;8134.918650813416;9024.729258122266;10806.35161890289;10814;11096.22326437174;11124.555017799521 11:48:29 INFO - PROCESS | 1668 | |3;mootools.html;1382.4470211915227;1530.1584128729203;1590.7772911792351;1735.4533322003567;1759.4018033868483;8056.677732890685;8485.618147183377;8648.91351086489;8682.262007729334;8687.174718401757;8445.155484451552;8656.2642175415;8683.522406267653;8718.433301835375;8721.7819554511;2202.2292197730744;2463.5442443147986;2480.9503809923835;2521.0924067335745;2536.6195070739354;2535.163396079289;2537.314924970257;2538.0228611984335;2541.542522345977;2548.872556372183;2411.0958390603523;2507.2227609441043;2509.2723110297993;2510.083819405913;2510.2971168072877;2444.095684596693;2487.639292302615;2511.9120830771017;2514.5473814713346;2514.7610976957344;2474.938126546833;2498.7376325485743;2502.51201015802;2511.937201569957;2515.8742062896963;8770.429922055046;8776.561171941441;8863.202311791969;8869.778255543599;8896.8665470018;5509.118541033416;5598.664080155204;5614.522765564931;5657.8585535361535;5675.6878371689545;3633.301488186101;3721.5534135903595;3762.1535154590274;3771.4908487354132;3772.5284339457567;1044.3733759744168;1061.9893801061967;1070.0530030922612;1080.7841178673991;1083.6748975307376;12143.574974875837;12332.50669973209;12346.320952347618;12361.196522226117;12366.62900112998;4902.117618828645;4902.828401005948;4982.950170498249;5015.724135172528;5017.347744793154;10501.474926253657;10520.26358154937;10537;10543.736406589896;10564.947175264075;5612.438756124437;5613;5615.241942337732;5625.09998400254;5631.746571404296;4441.933370999438;4532.252178390529;4592.425946756655;4597.839075632337;4844.781984810692;3297.4394352960053;3829.5596006459054;3907.1794923066473;3933.4296527003426;3943.7633741975574;1283.544341758681;1323.4243104249683;1330.2484096485455;1335.9599212023654;1343.1202562321696;1326.7014921642553;1337.1709540085014;1346.5421756602802;1398.9650258743409;1402.0396028720359;8122.75631731049;8390.244877961013;8395.454295470774;8399;8401.53791541471;515.8839261166207;519.888224031835;530.0882482130729;531.6544246239897;533.0964015992855;6192.442680158807;6240.625562466266;6282.654454004982;6284.748610055638;6289.056641503811;10517.316374435637;10824.07995320391;10938.617148399768;10940.890591093987;10959.0684791792;10405.167586593054;10643.893561064291;10720.35677859331;10784.245102842882;10794.082502987334;8245.628946697412;8361.665533378718;8416.116307787717;8427.41008129425;8434.325253979667;7716.228377162463;7890.132085470479;7912.406569507195;7922.7227047053075;7937.007874015748;9420.434773913586;9626.9037309626;9628.807423851344;9677;9801.11789938909;9755.609775608897;10041.246906482189;10127.291089623655;10185.134263587383;10209.132223760766;7554.811129721801;7558;7607.809804754704;7628.847423051397;7658.8085297868;6879.415249703831;8262.091169971418;8310.085890551914;8323.95838020806;8348.457350272212;7342.155652099863;7456.850862982818;7464.402847772057;7596.886046709194;7610.9238907610215;7349.375303099297;7382.756705285063;7448.627568621656;7452.180260171268;7524.134724506533;7792.376609871083;7825.843483130419;7869.921300786918;7879.369650427838;7890.408219383684;7046.4010559101;7049.718011279491;7118.181409138016;7132.679029443584;7134.072570565793;7141.9642901785155;7175.46184036189;7218.025566548658;7221.097362829646;7229.783106506813 11:48:29 INFO - PROCESS | 1668 | |4;prototype.html;324.3917654398004;327.7410845432109;330.57686161713013;334.8827910231419;337.5830848901606;5694.54443644508;5845.707714614268;6309.369063093694;6383.8509068367675;6395.168628078343;6146.170267013952;6290.056491526273;6305;6432.807015789534;6480.481561475082;4473.306637471197;4569.246074397721;4593.104344652794;4655.604273636728;4740.69185502942;4649.976750116261;4714.222153344711;4715.41057367829;4723.433188017443;4739.5023522530155;4171.541130475645;4252.638525725317;4637.791299391535;4652.604528615055;4657.115148121863;4448.4439445069365;4494.730316181007;4579.923717926301;4590.517995610479;4622.6070783983405;4007.2586571484076;4007.579204183548;4010.2981978154;4014.116894283253;4028.1742242840146;6057.061155520902;6083.178770865965;6097.237845269341;6106.633601983851;6119.969400153015;5506.449355064502;5507.586930980193;5512.33851937766;5515.669059856422;5518.944810551883;6733.259341472434;6749.122614060141;6771.559848609874;6779.898301525481;6782.932170678279;4248.660107191417;4414.514403415622;4420.513743488214;4422.601965823092;4433.379326894237;6958.756443524503;7082.92917070833;7115.608641524714;7133.001379806831;7138;4455.086707225011;4459.0858873930765;4477.328400739915;4479.037007043501;4499.707519011319;4525.343825145402;4525.570070843265;4533.32000199966;4534.161180181677;4545.772711364419;5336.066188417011;5345.091334473149;5346.1713434417725;5348.171033489815;5351.839444816662;6510.479161667055;6718.899216511756;6746.494012949049;6759.155105611799;6813.931860681429;1544.9227538623024;1551.1468692219235;1559.0723519506103;1563.234015332479;1564.1709893756326;819.7335865843505;996.153269720746;1020.285799940045;1024.6925922223304;1028.4703377760459;5948.10778383246;6071.9696401518595;6108.5723999319625;6230.439260466489;6242.063690446378;6945.305469453015;6972;6978.302169783083;6982.650867456607;6991.965040174767;6183.690815459209;6192.752289908443;6192.845178870474;6195.411435913581;6250.6874656267;3653.94519082214;3715.498407714924;3716.6097559756377;3723.1064544509663;3748.9250214995545;5885.5585831062845;6662.967240077795;7092.929070709227;7349.375303099189;7375.963120184472;6325.620462772156;6576.44100251484;6787.457003439713;7252.564846109145;7271.854562908712;7332.853342933112;7342.339189472973;7348.301911318416;7350.52221605594;7410.814729631695;6999.370056694922;7016.19313778922;7023.68393422287;7025.824354391181;7101.644917754195;5571.637843540157;6666.500012499179;6929.618870962146;6935.687894044881;6936.687849046906;7309.903514472871;7353.0441042664115;7358.080239970004;7362.263773622595;7371.447141464519;4447.243968525294;4453.910921781611;4463.509014008521;4464.933026004677;4472.686911916135;6960.756373526902;6974.895376569254;6976.581405115507;7013.05323781283;7039.788806335818;6462.741490340334;6681.098051763144;6780.084688566981;6783.830404239933;6786.728530858908;5201.7399130044105;6681.09805176295;6726.7981960541265;6738.831529211809;6766.627835469097;5769.278840144982;6177.9691101546005;6584.8024559263295;6598.307177746267;6600.900986485302;5397.541208997122;6696.665166741741;6705.698243578953;6705.832354191184;6715;5295.629305948547;6407.1350367701625;6589.209294884645;6601.53789234749;6612.867742645024 11:48:29 INFO - PROCESS | 1668 | |5;yui.html;694.1462001737863;740.93702035327;750.193541942412;760.9010828592283;807.7334479621724;15078.924605376971;15275.694486110271;15298.541043768677;15301.46444874431;15304.158271295075;15787.526374208763;16147.192640367964;16163.434279800209;16178.595535111628;16229.188540572983;735.3308489274762;748.2517482517483;912.0423555266959;925.5788616179622;933.8552524358702;903.1961554216753;918.2424499787669;920.4753290624346;921.262989608314;921.4701546610692;977.9315447918649;978.7063880835757;979.5591983607405;983.1397527163732;984.2863923655365;761.6268028665913;955.0544960489135;969.9175570076552;970.6554173268458;974.0211087856729;726.0234983946583;727.439871299102;727.5452841973766;728.0135416510658;729.3472342253706;15267.541973740805;15280.31238594266;15388.692226155414;15403.61490962735;15466.5360039199;12270.141090123694;12337.444814983348;12396.504139834396;12589.622311330675;12781.680457988532;9846.96606856284;10029.849552256723;10103.343282686601;10448.947755261252;10975.83536246957;3105.5186446100893;3616.801199661469;3638.1450359165574;3649.233660931208;3738.55137383513;74934.62532687356;79936;80534.59732701357;80968;81277.59361203216;7885.921140788633;9087.182153606207;9189.448633082036;9553.331266811396;9556.808863822824;20590.27934022302;20742.688859667116;21058.78941210599;21090.789092108884;21104.894475527522;7262.491625586158;7446.106467223968;7495.625218739041;7498.4001279897475;7565.130010048805;3936.252112098692;4070.6946978976694;4137.8965525861495;4162.937555936664;4180.017695841475;3653.5250417446096;3706.295803797324;3712.888613341604;3716.925661486755;3718.3121122592406;660.1121491593799;664.4617859533793;679.341039191983;680.829792551862;682.4676752133344;511.2254933775333;562.1595714406988;584.5995493087249;598.3956204233755;611.0986295214611;7740.26467485588;8160.551169685606;8233.547154906537;8287.378446616527;8300.335973122135;570.3127731084033;577.7891069759507;581.2937281203358;597.9581429299907;605.8636806718541;3722.2927643748144;3829.272438236726;3873.9806300968316;3874.3994680824517;3900.356441187229;71908.64045679843;81595;82535.17464825275;82735.17264827275;82880.58559707162;76175;76220;76453.61773191098;76600.46799063988;78054.609726951;61412;64280.35719642837;66849.65202783766;70017.64991175216;71227.64386178037;6751.3248675134055;7404.630143423484;8081.232282933112;8282.550553653207;8402.537860417735;38403;46246.768766155954;47898.04203915972;48895.75552122359;51841.22238166506;65488;69474.65262673654;70407.59184816378;70507.64746176236;70547.64726176337;10829.133669306279;10946.890531094587;11169;11231.269967452416;11446.771064578828;11495.655130346104;11903.166778325434;11921.701957451132;11925.880741192477;12725.87274127247;10050.24623153281;11400.657980260605;11538.307701537935;11768.882311176778;11861.76276474483;11332.603358882729;11433.142514311294;11478.94260528692;11561.190716649753;11798.351090690094;11155.553777848796;11231.045361144394;11233.831492527783;11620.837916208311;11701.824472632747;9643.758906027406;9722.75693107678;9747.707568772948;9814.2148628111;9918.30571859963;8706.869396958924;8926.553672316488;9220.677276295297;9324.580393882155;9811.411315320818 11:48:29 INFO - PROCESS | 1668 | __end_tp_report 11:48:29 INFO - PROCESS | 1668 | __start_cc_report 11:48:29 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1300 11:48:29 INFO - PROCESS | 1668 | __end_cc_report 11:48:29 INFO - PROCESS | 1668 | __startTimestamp1459363709662__endTimestamp 11:48:29 INFO - PROCESS | 1668 | 11:48:29 INFO - PROCESS | 1668 | ------- Summary: start ------- 11:48:29 INFO - PROCESS | 1668 | Number of tests: 6 11:48:29 INFO - PROCESS | 1668 | 11:48:29 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5671.17 Median:5922.02 stddev:660.13 (11.1%) stddev-sans-first:633.54 11:48:29 INFO - PROCESS | 1668 | Values: 3220.5 3464.0 3497.3 3500.8 3551.4 4597.6 5476.4 5589.0 5653.7 5667.1 5628.5 5636.8 5648.7 5778.1 5792.7 5018.4 5039.1 5075.8 5084.2 5196.0 5225.4 5249.6 5260.6 5276.5 5284.2 5023.1 5038.2 5124.1 5160.0 5204.9 5006.6 5015.7 5018.1 5031.5 5052.8 4947.9 4977.7 4984.2 5002.0 5007.4 5147.6 5454.3 5504.6 5621.4 5695.5 5749.5 6167.1 6170.9 6176.0 6187.2 6209.0 6263.0 6268.0 6274.5 6288.9 5645.9 5736.0 5754.7 5854.8 5922.0 6205.8 6216.2 6229.7 6237.4 6247.3 6044.1 6060.5 6109.6 6116.1 6119.5 6032.6 6108.4 6134.3 6227.3 6234.3 6122.8 6145.2 6146.3 6152.6 6169.7 6182.5 6186.4 6203.9 6205.0 6206.7 4731.4 4834.9 4865.4 4865.8 4870.4 3768.3 4426.6 4441.8 4472.0 4487.2 5609.2 5636.8 5721.9 5740.4 5752.1 6201.2 6213.9 6224.4 6228.1 6230.6 5603.9 5727.6 5732.2 5747.2 5820.0 5313.8 5319.8 5365.9 5400.0 5409.7 6251.7 6260.1 6280.4 6281.6 6286.7 6108.0 6118.8 6221.8 6252.9 6253.4 6163.3 6222.3 6252.6 6296.7 6305.8 6144.0 6159.2 6174.0 6175.5 6176.0 6124.2 6236.5 6240.1 6250.3 6267.6 6014.1 6038.8 6100.9 6120.2 6134.0 4279.6 5263.9 5718.2 6039.5 6109.2 5776.7 5895.4 5924.6 5928.3 5950.4 6006.1 6009.4 6098.5 6125.9 6140.0 5916.2 5920.3 5924.5 5935.2 5965.6 11:48:29 INFO - PROCESS | 1668 | 11:48:29 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:55253.36 Median:37550.53 stddev:111285.95 (296.4%) stddev-sans-first:111522.17 11:48:29 INFO - PROCESS | 1668 | Values: 487.9 577.6 589.2 628.2 640.2 38277.6 38762.0 38783.8 38833.0 38842.8 41625.0 41920.7 42061.4 42151.0 42171.8 9401.4 9631.5 9631.6 9634.6 9641.6 9446.6 9577.3 9586.8 9604.2 9614.9 9669.0 9739.9 9740.6 9759.3 9766.1 8974.6 9087.2 9622.4 9725.0 9734.4 9509.8 9649.2 9653.7 9657.1 9663.0 39835.0 40228.0 40277.4 40378.2 40393.0 3127.0 3237.4 3268.2 3695.4 4131.6 28046.0 28141.0 28615.1 28643.0 28833.0 2519.3 2527.1 2540.6 2588.7 2685.0 429237.0 432607.0 436286.0 436421.0 436812.8 42841.8 46515.3 46530.8 55901.3 61682.7 45689.0 45747.5 45936.9 46064.0 46116.8 15834.9 15999.5 15999.8 16001.8 16006.9 12800.2 12851.8 12880.9 12895.1 12933.5 14797.1 14862.4 14878.9 14889.9 15001.0 6190.8 6293.9 6329.5 6340.8 6356.3 966.6 967.8 1001.5 1006.3 1034.7 28714.7 29160.4 29328.6 29375.0 29375.9 1106.9 1117.3 1121.0 1198.3 1212.3 11709.7 14396.7 14545.5 14963.7 15074.0 429422.0 509849.5 516104.0 516524.0 518506.0 42258.2 58150.8 58467.4 58517.4 61168.0 1311.5 1447.3 1456.6 1477.0 1490.6 27983.3 28090.3 28403.6 28631.1 28730.6 44324.1 44756.8 44832.0 44869.6 44897.3 267930.0 304817.0 305233.0 305352.0 305506.0 27963.4 32006.5 32166.7 32506.0 32748.8 40217.6 40668.0 41833.4 42029.0 42171.6 32922.3 34402.5 34490.0 35169.8 35194.0 26151.9 33995.3 34914.0 35500.5 35681.5 35981.6 36240.1 36298.0 37124.8 37976.2 30062.8 31300.7 31326.9 31382.7 31796.8 23587.3 24286.6 24303.8 24464.5 24536.2 11:48:29 INFO - PROCESS | 1668 | 11:48:29 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:30692.25 Median:366.51 stddev:88423.46 (24125.5%) stddev-sans-first:88642.18 11:48:29 INFO - PROCESS | 1668 | Values: 361.7 364.9 368.2 375.0 376.2 19324.5 19537.6 20198.6 20233.7 20646.7 10728.6 12247.8 12247.9 12253.0 12258.8 4643.2 4654.9 4889.9 4900.2 5277.3 5221.9 5250.7 5280.3 5283.7 5296.5 5156.5 5270.7 5271.6 5278.9 5749.5 5693.0 5727.1 5757.4 5761.4 5772.1 5073.8 5084.4 5086.0 5088.3 5342.8 12974.2 13317.1 13354.3 13366.0 13372.2 2019.7 2168.6 2179.2 2187.8 2587.9 9344.7 9895.0 10050.2 12830.9 13852.9 1678.9 1733.8 1772.4 1777.4 1814.0 87333.7 87446.6 88017.0 96988.0 101328.0 10962.1 11186.4 11362.1 11482.6 11635.2 13802.4 13844.0 13862.9 13891.1 13891.6 8351.2 8498.5 8521.7 8570.5 8632.4 8596.2 8603.0 8633.4 8711.5 8713.5 4344.2 4439.0 4468.9 4473.8 4474.6 1807.2 1862.6 1865.1 1875.7 1894.5 900.3 921.2 995.3 1008.5 1018.0 18391.4 19082.1 19540.5 19957.9 20014.2 906.4 932.6 951.8 970.5 982.5 9987.8 10287.4 10290.3 10325.1 10470.9 493090.0 503435.0 503616.0 547504.0 605970.0 69928.6 94005.0 112494.3 121749.2 122091.4 1034.9 1055.9 1082.5 1131.4 1134.1 13938.2 17338.7 17511.9 17866.8 18184.9 46256.8 50389.0 50879.0 50970.0 52635.7 65277.7 72626.6 72635.6 72854.0 73343.5 7462.6 7787.0 7866.1 7898.2 8083.3 11705.4 12339.2 12511.9 12613.8 12777.9 9958.8 9964.9 9976.9 10122.6 10794.8 10730.3 10772.3 10817.0 11114.6 11185.5 10783.7 11058.2 11385.9 11398.7 11469.6 7702.8 7704.3 7811.3 7857.2 8134.9 9024.7 10806.4 10814.0 11096.2 11124.6 11:48:29 INFO - PROCESS | 1668 | 11:48:29 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6117.85 Median:524.99 stddev:3259.74 (620.9%) stddev-sans-first:3249.45 11:48:29 INFO - PROCESS | 1668 | Values: 1382.4 1530.2 1590.8 1735.5 1759.4 8056.7 8485.6 8648.9 8682.3 8687.2 8445.2 8656.3 8683.5 8718.4 8721.8 2202.2 2463.5 2481.0 2521.1 2536.6 2535.2 2537.3 2538.0 2541.5 2548.9 2411.1 2507.2 2509.3 2510.1 2510.3 2444.1 2487.6 2511.9 2514.5 2514.8 2474.9 2498.7 2502.5 2511.9 2515.9 8770.4 8776.6 8863.2 8869.8 8896.9 5509.1 5598.7 5614.5 5657.9 5675.7 3633.3 3721.6 3762.2 3771.5 3772.5 1044.4 1062.0 1070.1 1080.8 1083.7 12143.6 12332.5 12346.3 12361.2 12366.6 4902.1 4902.8 4983.0 5015.7 5017.3 10501.5 10520.3 10537.0 10543.7 10564.9 5612.4 5613.0 5615.2 5625.1 5631.7 4441.9 4532.3 4592.4 4597.8 4844.8 3297.4 3829.6 3907.2 3933.4 3943.8 1283.5 1323.4 1330.2 1336.0 1343.1 1326.7 1337.2 1346.5 1399.0 1402.0 8122.8 8390.2 8395.5 8399.0 8401.5 515.9 519.9 530.1 531.7 533.1 6192.4 6240.6 6282.7 6284.7 6289.1 10517.3 10824.1 10938.6 10940.9 10959.1 10405.2 10643.9 10720.4 10784.2 10794.1 8245.6 8361.7 8416.1 8427.4 8434.3 7716.2 7890.1 7912.4 7922.7 7937.0 9420.4 9626.9 9628.8 9677.0 9801.1 9755.6 10041.2 10127.3 10185.1 10209.1 7554.8 7558.0 7607.8 7628.8 7658.8 6879.4 8262.1 8310.1 8324.0 8348.5 7342.2 7456.9 7464.4 7596.9 7610.9 7349.4 7382.8 7448.6 7452.2 7524.1 7792.4 7825.8 7869.9 7879.4 7890.4 7046.4 7049.7 7118.2 7132.7 7134.1 7142.0 7175.5 7218.0 7221.1 7229.8 11:48:29 INFO - PROCESS | 1668 | 11:48:29 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5481.04 Median:6180.83 stddev:1743.00 (28.2%) stddev-sans-first:1704.37 11:48:29 INFO - PROCESS | 1668 | Values: 324.4 327.7 330.6 334.9 337.6 5694.5 5845.7 6309.4 6383.9 6395.2 6146.2 6290.1 6305.0 6432.8 6480.5 4473.3 4569.2 4593.1 4655.6 4740.7 4650.0 4714.2 4715.4 4723.4 4739.5 4171.5 4252.6 4637.8 4652.6 4657.1 4448.4 4494.7 4579.9 4590.5 4622.6 4007.3 4007.6 4010.3 4014.1 4028.2 6057.1 6083.2 6097.2 6106.6 6120.0 5506.4 5507.6 5512.3 5515.7 5518.9 6733.3 6749.1 6771.6 6779.9 6782.9 4248.7 4414.5 4420.5 4422.6 4433.4 6958.8 7082.9 7115.6 7133.0 7138.0 4455.1 4459.1 4477.3 4479.0 4499.7 4525.3 4525.6 4533.3 4534.2 4545.8 5336.1 5345.1 5346.2 5348.2 5351.8 6510.5 6718.9 6746.5 6759.2 6813.9 1544.9 1551.1 1559.1 1563.2 1564.2 819.7 996.2 1020.3 1024.7 1028.5 5948.1 6072.0 6108.6 6230.4 6242.1 6945.3 6972.0 6978.3 6982.7 6992.0 6183.7 6192.8 6192.8 6195.4 6250.7 3653.9 3715.5 3716.6 3723.1 3748.9 5885.6 6663.0 7092.9 7349.4 7376.0 6325.6 6576.4 6787.5 7252.6 7271.9 7332.9 7342.3 7348.3 7350.5 7410.8 6999.4 7016.2 7023.7 7025.8 7101.6 5571.6 6666.5 6929.6 6935.7 6936.7 7309.9 7353.0 7358.1 7362.3 7371.4 4447.2 4453.9 4463.5 4464.9 4472.7 6960.8 6974.9 6976.6 7013.1 7039.8 6462.7 6681.1 6780.1 6783.8 6786.7 5201.7 6681.1 6726.8 6738.8 6766.6 5769.3 6178.0 6584.8 6598.3 6600.9 5397.5 6696.7 6705.7 6705.8 6715.0 5295.6 6407.1 6589.2 6601.5 6612.9 11:48:29 INFO - PROCESS | 1668 | 11:48:29 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:17793.94 Median:64884.18 stddev:24422.12 (37.6%) stddev-sans-first:24456.87 11:48:29 INFO - PROCESS | 1668 | Values: 694.1 740.9 750.2 760.9 807.7 15078.9 15275.7 15298.5 15301.5 15304.2 15787.5 16147.2 16163.4 16178.6 16229.2 735.3 748.3 912.0 925.6 933.9 903.2 918.2 920.5 921.3 921.5 977.9 978.7 979.6 983.1 984.3 761.6 955.1 969.9 970.7 974.0 726.0 727.4 727.5 728.0 729.3 15267.5 15280.3 15388.7 15403.6 15466.5 12270.1 12337.4 12396.5 12589.6 12781.7 9847.0 10029.8 10103.3 10448.9 10975.8 3105.5 3616.8 3638.1 3649.2 3738.6 74934.6 79936.0 80534.6 80968.0 81277.6 7885.9 9087.2 9189.4 9553.3 9556.8 20590.3 20742.7 21058.8 21090.8 21104.9 7262.5 7446.1 7495.6 7498.4 7565.1 3936.3 4070.7 4137.9 4162.9 4180.0 3653.5 3706.3 3712.9 3716.9 3718.3 660.1 664.5 679.3 680.8 682.5 511.2 562.2 584.6 598.4 611.1 7740.3 8160.6 8233.5 8287.4 8300.3 570.3 577.8 581.3 598.0 605.9 3722.3 3829.3 3874.0 3874.4 3900.4 71908.6 81595.0 82535.2 82735.2 82880.6 76175.0 76220.0 76453.6 76600.5 78054.6 61412.0 64280.4 66849.7 70017.6 71227.6 6751.3 7404.6 8081.2 8282.6 8402.5 38403.0 46246.8 47898.0 48895.8 51841.2 65488.0 69474.7 70407.6 70507.6 70547.6 10829.1 10946.9 11169.0 11231.3 11446.8 11495.7 11903.2 11921.7 11925.9 12725.9 10050.2 11400.7 11538.3 11768.9 11861.8 11332.6 11433.1 11478.9 11561.2 11798.4 11155.6 11231.0 11233.8 11620.8 11701.8 9643.8 9722.8 9747.7 9814.2 9918.3 8706.9 8926.6 9220.7 9324.6 9811.4 11:48:29 INFO - PROCESS | 1668 | -------- Summary: end -------- 11:48:29 INFO - PROCESS | 1668 | 11:48:30 INFO - TEST-INFO | 1668: exit 0 11:48:30 INFO - TEST-OK | dromaeo_css | took 1112504ms 11:48:30 INFO - TEST-START | kraken 11:48:30 INFO - operating with platform_type : mac_ 11:48:30 INFO - Initialising browser for kraken test... 11:48:30 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpFbI1Ua/profile http://localhost:49271/getInfo.html) 11:48:32 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 11:48:32 INFO - PROCESS | 1675 | colorDepth:24 11:48:32 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 11:48:32 INFO - PROCESS | 1675 | __metrics 11:48:32 INFO - PROCESS | 1675 | 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" 11:48:32 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:48:33 INFO - TEST-INFO | 1675: exit 0 11:48:33 INFO - Browser initialized. 11:48:33 INFO - Running cycle 1/1 for kraken test... 11:48:33 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpFbI1Ua/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:48:45 INFO - PROCESS | 1677 | RSS: Main: 244350976 11:48:45 INFO - PROCESS | 1677 | 11:48:48 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 11:48:48 INFO - PROCESS | 1677 | RSS: Main: 290766848 11:48:48 INFO - PROCESS | 1677 | 11:48:51 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 11:48:52 INFO - PROCESS | 1677 | RSS: Main: 300961792 11:48:52 INFO - PROCESS | 1677 | 11:48:55 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 11:48:55 INFO - PROCESS | 1677 | RSS: Main: 286728192 11:48:55 INFO - PROCESS | 1677 | 11:48:57 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 11:48:58 INFO - PROCESS | 1677 | RSS: Main: 289656832 11:48:58 INFO - PROCESS | 1677 | 11:49:00 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:49:01 INFO - PROCESS | 1677 | RSS: Main: 290811904 11:49:01 INFO - PROCESS | 1677 | 11:49:03 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 11:49:04 INFO - PROCESS | 1677 | RSS: Main: 290770944 11:49:04 INFO - PROCESS | 1677 | 11:49:07 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 11:49:07 INFO - PROCESS | 1677 | RSS: Main: 290947072 11:49:07 INFO - PROCESS | 1677 | 11:49:10 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 11:49:11 INFO - PROCESS | 1677 | RSS: Main: 291196928 11:49:11 INFO - PROCESS | 1677 | 11:49:12 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:49:13 INFO - PROCESS | 1677 | RSS: Main: 324558848 11:49:13 INFO - PROCESS | 1677 | 11:49:15 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:49:16 INFO - PROCESS | 1677 | RSS: Main: 325697536 11:49:16 INFO - PROCESS | 1677 | 11:49:18 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:49:18 INFO - PROCESS | 1677 | RSS: Main: 331481088 11:49:18 INFO - PROCESS | 1677 | 11:49:21 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:49:21 INFO - PROCESS | 1677 | RSS: Main: 332709888 11:49:21 INFO - PROCESS | 1677 | 11:49:24 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:49:25 INFO - PROCESS | 1677 | RSS: Main: 332746752 11:49:25 INFO - PROCESS | 1677 | 11:49:26 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 11:49:27 INFO - PROCESS | 1677 | RSS: Main: 396140544 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | __start_tp_report 11:49:27 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 11:49:27 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 11:49:27 INFO - PROCESS | 1677 | |i|pagename|runs| 11:49:27 INFO - PROCESS | 1677 | |0;ai-astar;113;109;114;115;156;168;118;113;111;110 11:49:27 INFO - PROCESS | 1677 | |1;audio-beat-detection;156;126;132;189;147;147;163;148;168;122 11:49:27 INFO - PROCESS | 1677 | |2;audio-dft;186;183;184;182;181;184;179;182;181;182 11:49:27 INFO - PROCESS | 1677 | |3;audio-fft;76;77;88;82;55;58;57;79;79;58 11:49:27 INFO - PROCESS | 1677 | |4;audio-oscillator;92;95;128;80;77;89;114;78;78;117 11:49:27 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;87;84;86;84;87;83;87;84;86;83 11:49:27 INFO - PROCESS | 1677 | |6;imaging-darkroom;93;93;94;93;93;92;92;93;93;93 11:49:27 INFO - PROCESS | 1677 | |7;imaging-desaturate;127;140;94;83;88;84;105;143;140;86 11:49:27 INFO - PROCESS | 1677 | |8;json-parse-financial;55;54;56;56;54;54;53;65;56;53 11:49:27 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;65;63;71;79;70;67;67;67;67;69 11:49:27 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;85;83;84;83;84;82;83;81;82;79 11:49:27 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;124;133;131;135;119;125;126;111;146;109 11:49:27 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;141;139;132;141;140;156;165;180;135;127 11:49:27 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;68;68;67;67;69;68;68;69;66;67 11:49:27 INFO - PROCESS | 1677 | __end_tp_report 11:49:27 INFO - PROCESS | 1677 | __start_cc_report 11:49:27 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1293 11:49:27 INFO - PROCESS | 1677 | __end_cc_report 11:49:27 INFO - PROCESS | 1677 | __startTimestamp1459363767029__endTimestamp 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | ------- Summary: start ------- 11:49:27 INFO - PROCESS | 1677 | Number of tests: 14 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:122.70 Median:114.50 stddev:21.06 (18.4%) stddev-sans-first:22.04 11:49:27 INFO - PROCESS | 1677 | Values: 113.0 109.0 114.0 115.0 156.0 168.0 118.0 113.0 111.0 110.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:152.00 stddev:20.43 (13.4%) stddev-sans-first:21.54 11:49:27 INFO - PROCESS | 1677 | Values: 156.0 126.0 132.0 189.0 147.0 147.0 163.0 148.0 168.0 122.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:182.40 Median:182.50 stddev:1.96 (1.1%) stddev-sans-first:1.58 11:49:27 INFO - PROCESS | 1677 | Values: 186.0 183.0 184.0 182.0 181.0 184.0 179.0 182.0 181.0 182.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:70.90 Median:78.00 stddev:12.42 (15.9%) stddev-sans-first:13.04 11:49:27 INFO - PROCESS | 1677 | Values: 76.0 77.0 88.0 82.0 55.0 58.0 57.0 79.0 79.0 58.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:79.00 stddev:18.58 (23.5%) stddev-sans-first:19.68 11:49:27 INFO - PROCESS | 1677 | Values: 92.0 95.0 128.0 80.0 77.0 89.0 114.0 78.0 78.0 117.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.66 (1.9%) stddev-sans-first:1.62 11:49:27 INFO - PROCESS | 1677 | Values: 87.0 84.0 86.0 84.0 87.0 83.0 87.0 84.0 86.0 83.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 11:49:27 INFO - PROCESS | 1677 | Values: 93.0 93.0 94.0 93.0 93.0 92.0 92.0 93.0 93.0 93.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:109.00 Median:83.50 stddev:25.63 (30.7%) stddev-sans-first:26.35 11:49:27 INFO - PROCESS | 1677 | Values: 127.0 140.0 94.0 83.0 88.0 84.0 105.0 143.0 140.0 86.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:3.50 (6.3%) stddev-sans-first:3.71 11:49:27 INFO - PROCESS | 1677 | Values: 55.0 54.0 56.0 56.0 54.0 54.0 53.0 65.0 56.0 53.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:4.35 (6.4%) stddev-sans-first:4.43 11:49:27 INFO - PROCESS | 1677 | Values: 65.0 63.0 71.0 79.0 70.0 67.0 67.0 67.0 67.0 69.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.71 (2.1%) stddev-sans-first:1.58 11:49:27 INFO - PROCESS | 1677 | Values: 85.0 83.0 84.0 83.0 84.0 82.0 83.0 81.0 82.0 79.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:128.50 stddev:11.17 (8.7%) stddev-sans-first:11.83 11:49:27 INFO - PROCESS | 1677 | Values: 124.0 133.0 131.0 135.0 119.0 125.0 126.0 111.0 146.0 109.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.60 Median:141.00 stddev:16.43 (11.6%) stddev-sans-first:17.34 11:49:27 INFO - PROCESS | 1677 | Values: 141.0 139.0 132.0 141.0 140.0 156.0 165.0 180.0 135.0 127.0 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 11:49:27 INFO - PROCESS | 1677 | Values: 68.0 68.0 67.0 67.0 69.0 68.0 68.0 69.0 66.0 67.0 11:49:27 INFO - PROCESS | 1677 | -------- Summary: end -------- 11:49:27 INFO - PROCESS | 1677 | 11:49:27 INFO - TEST-INFO | 1677: exit 0 11:49:27 INFO - TEST-OK | kraken | took 57489ms 11:49:27 INFO - SUITE-END | took 1169s 11:49:28 INFO - Completed test suite (00:19:30) 11:49:28 INFO - javascript benchmark 11:49:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3220.484722444409, 3464.0127563644364, 3497.300539892019, 3500.7724497907643, 3551.4140166872467, 4597.563231493007, 5476.3702174249975, 5588.972055139729, 5653.717314134292, 5667.0932650775885, 5628.493435590796, 5636.830895073144, 5648.74580643871, 5778.133280008001, 5792.6814025228705, 5018.397792264915, 5039.09296326661, 5075.771590278447, 5084.1611134163, 5196.020831881145, 5225.425203227642, 5249.606279529032, 5260.631755777097, 5276.525112739852, 5284.2073688946775, 5023.120953833083, 5038.2190760432195, 5124.103281925648, 5159.974200129013, 5204.895902081975, 5006.6245031622775, 5015.724135172564, 5018.096742586333, 5031.52200540948, 5052.7726252318735, 4947.851564453073, 4977.676451030671, 4984.2025275955675, 5001.9749901250625, 5007.399112106534, 5147.588192944556, 5454.263674403984, 5504.614676972614, 5621.409751976024, 5695.544356451515, 5749.482546570829, 6167.074938759222, 6170.876582468325, 6175.96912015437, 6187.226596675416, 6209.0, 6262.968685156545, 6268.0, 6274.466670333027, 6288.9056664150075, 5645.915311270334, 5735.999999999958, 5754.654720716729, 5854.795082172103, 5922.022866227025, 6205.844853878689, 6216.222972128484, 6229.719662615194, 6237.376262373817, 6247.250329960434, 6044.093385992049, 6060.545459090586, 6109.633421994695, 6116.082587611805, 6119.5104391648565, 6032.577719559588, 6108.37242585679, 6134.252905685651, 6227.252729672468, 6234.314225435199, 6122.816315510542, 6145.231846019247, 6146.293176284785, 6152.600080994721, 6169.691515424301, 6182.474489668339, 6186.381361863868, 6203.937960620336, 6205.007198848162, 6206.72069756862, 4731.361266229015, 4834.927476087792, 4865.440474345495, 4865.756712164378, 4870.439899411542, 3768.2840260350445, 4426.601605855489, 4441.822327106879, 4471.99380139466, 4487.214737420938, 5609.214709940612, 5636.774529018875, 5721.8569535761935, 5740.39725828782, 5752.108423194411, 6201.224846894138, 6213.937860621426, 6224.37756224383, 6228.128062071313, 6230.56386052981, 5603.887922241533, 5727.570432217601, 5732.226149469851, 5747.195392645033, 5820.0, 5313.760880760375, 5319.760610772524, 5365.865853353619, 5400.000999814968, 5409.7295135243085, 6251.6561589113035, 6260.060990851409, 6280.434760871543, 6281.59169653971, 6286.654234017082, 6107.969460152671, 6118.816435506942, 6221.813345599639, 6252.9062064069985, 6253.405926436982, 6163.322034576104, 6222.315545289924, 6252.5935814171935, 6296.716647750954, 6305.842353941188, 6144.047672610753, 6159.19930409044, 6174.043023331391, 6175.505959523317, 6176.0, 6124.234470691164, 6236.532260080421, 6240.095186198067, 6250.312465628868, 6267.561270711189, 6014.127951446928, 6038.849028774316, 6100.944524685144, 6120.17287048654, 6133.969330153321, 4279.636230920407, 5263.868403289948, 5718.228039214653, 6039.456448919618, 6109.236345456818, 5776.682282474504, 5895.4399332063385, 5924.585279030426, 5928.318243402064, 5950.404959504015, 6006.129111278753, 6009.429104235265, 6098.542609304409, 6125.890594128479, 6139.982816839612, 5916.201312822886, 5920.319163296276, 5924.526037917042, 5935.228420305505, 5965.642061476326], "unit": "score", "name": "dojo.html", "value": 5629.495268439648}, {"lowerIsBetter": false, "replicates": [487.9146149423854, 577.59279707806, 589.1692713274282, 628.2084573437469, 640.1901594482979, 38277.61722382775, 38762.0, 38783.80608096955, 38833.0, 38842.80578597107, 41625.0, 41920.74237772872, 42061.36907946383, 42151.0, 42171.78914105425, 9401.435913845156, 9631.518424078804, 9631.614735410576, 9634.56644450998, 9641.61433542661, 9446.622135114587, 9577.329586928918, 9586.808263834719, 9604.183644390236, 9614.903850961506, 9669.0, 9739.853902191473, 9740.561674724619, 9759.316847820655, 9766.072223138826, 8974.596143173572, 9087.182563487297, 9622.422654640708, 9725.0, 9734.41593504385, 9509.762255943588, 9649.228061755042, 9653.71038868835, 9657.130858222723, 9663.0, 39835.00412489682, 40228.0, 40277.39583906244, 40378.19243615111, 40392.99017524556, 3127.0462508934766, 3237.4496335623003, 3268.215628249227, 3695.3533131701843, 4131.648809851166, 28046.0, 28141.015064472645, 28615.14154575366, 28643.0, 28832.990845320313, 2519.3071905226025, 2527.140772137482, 2540.618907163922, 2588.6505321781506, 2684.979707711077, 429236.99999999686, 432607.0, 436286.0, 436421.0, 436812.8159359183, 42841.78579107085, 46515.30227046597, 46530.76734616373, 55901.322960311256, 61682.69158654178, 45689.0, 45747.542524574994, 45936.8515787108, 46064.0, 46116.847078823295, 15834.92082539603, 15999.520014399586, 15999.760003599955, 16001.79986501017, 16006.919965400099, 12800.167989080866, 12851.807222891664, 12880.871191288155, 12895.097343185887, 12933.482660693655, 14797.112173269637, 14862.405503779728, 14878.925605371904, 14889.851101489063, 15001.0, 6190.81427557174, 6293.905591416133, 6329.493640508748, 6340.809775706736, 6356.300806911236, 966.5984322732066, 967.8064387122604, 1001.5342865567401, 1006.2654262388497, 1034.736142283728, 28714.712852871206, 29160.416791664473, 29328.560071598942, 29375.0, 29375.85312073426, 1106.8505751723576, 1117.2961034548182, 1120.9775804483866, 1198.3049831097942, 1212.3089838791805, 11709.707257318465, 14396.712065758626, 14545.490907818175, 14963.700725985636, 15074.0201886877, 429422.0, 509849.45075274387, 516104.0, 516524.0, 518506.0, 42258.15483690309, 58150.836983260946, 58467.415325846196, 58517.41482585205, 61168.0, 1311.4623004568082, 1447.2835946206694, 1456.6285597172653, 1477.0, 1490.567735356756, 27983.30041748891, 28090.2977425566, 28403.573946391232, 28631.14106576806, 28730.569041463976, 44324.11351773011, 44756.77621611871, 44832.0, 44869.55130448654, 44897.32654010127, 267930.0, 304817.0, 305233.0, 305352.0, 305506.0, 27963.44073118567, 32006.51990220102, 32166.678333217304, 32506.0, 32748.83625581857, 40217.59782402139, 40668.0, 41833.372499411926, 42029.0, 42171.57828421799, 32922.34155316928, 34402.48396274108, 34490.0, 35169.82415087908, 35194.0, 26151.869240653676, 33995.3200935975, 34914.0, 35500.46749298711, 35681.46477802783, 35981.64018359783, 36240.09399765027, 36298.0, 37124.81437592795, 37976.24047519089, 30062.849685751433, 31300.686993130686, 31326.903558375347, 31382.686173137976, 31796.841015794773, 23587.287461942095, 24286.63570046486, 24303.75696243015, 24464.51070978606, 24536.178339491187], "unit": "score", "name": "ext.html", "value": 18549.1836544587}, {"lowerIsBetter": false, "replicates": [361.7088243963609, 364.8668236093825, 368.16243047067917, 375.0492501508676, 376.24750499001993, 19324.454043676506, 19537.609247815035, 20198.596028079428, 20233.696494552594, 20646.690299645517, 10728.624498142566, 12247.755044899097, 12247.938760306208, 12253.019758419327, 12258.816117758219, 4643.164230438537, 4654.8595594079325, 4889.877753056176, 4900.191468407708, 5277.261183434322, 5221.947780522184, 5250.684958902478, 5280.260763493114, 5283.682979021271, 5296.523312901838, 5156.458571849939, 5270.683758974474, 5271.630985830993, 5278.894422111555, 5749.453801888835, 5693.032184528619, 5727.083666613322, 5757.366689664133, 5761.366249712528, 5772.09520858118, 5073.771680274396, 5084.44071152173, 5086.03365360584, 5088.262201980692, 5342.759575819097, 12974.221546707133, 13317.134386264861, 13354.26551539665, 13366.0, 13372.197668139943, 2019.7273368095414, 2168.6313326734494, 2179.2263746370127, 2187.7921597448217, 2587.896484140651, 9344.719658410258, 9895.01049895012, 10050.195984321237, 12830.90937270333, 13852.861471385359, 1678.8992660440413, 1733.7746093007954, 1772.3765011424255, 1777.4223377402395, 1813.954651133719, 87333.68999465014, 87446.56276718639, 88016.99999999936, 96988.03011969861, 101328.0, 10962.123030157569, 11186.384748838893, 11362.091032717362, 11482.598109066143, 11635.243709158878, 13802.37889294984, 13844.0, 13862.861371386158, 13891.097078690054, 13891.583252502442, 8351.1648835116, 8498.49009059446, 8521.659133634585, 8570.528620925785, 8632.395732298679, 8596.183362580545, 8603.01065377477, 8633.438826476258, 8711.477311361212, 8713.477191368538, 4344.152890186447, 4438.955610443919, 4468.865934021985, 4473.753943533072, 4474.597286244189, 1807.1777341309673, 1862.6274745050773, 1865.1420346640425, 1875.6717574424695, 1894.4506093232808, 900.3382513852313, 921.15714121578, 995.2883688162998, 1008.4604736465956, 1017.954192061359, 18391.356302529348, 19082.14130364137, 19540.51148721265, 19957.900210498854, 20014.235442269528, 906.4470672889532, 932.6129656192604, 951.8477043673117, 970.5147426286857, 982.4940155819759, 9987.750306242257, 10287.434191119411, 10290.279680422449, 10325.122364599094, 10470.895291046992, 493090.0, 503435.0, 503616.0, 547504.0, 605970.0, 69928.60142797115, 94005.0, 112494.31258531129, 121749.17376239364, 122091.38954305172, 1034.9482525873675, 1055.883852776194, 1082.4587706146926, 1131.4060118437721, 1134.0643968725835, 13938.233397163254, 17338.73991890148, 17511.912440437718, 17866.821331786516, 18184.909075455067, 46256.768716156206, 50389.0, 50878.98242035213, 50969.999999998516, 52635.73682131565, 65277.67361163354, 72626.63686681533, 72635.63682181555, 72854.0, 73343.53312933605, 7462.589557574169, 7786.961065194638, 7866.134725180111, 7898.170692077479, 8083.2725054743005, 11705.414729263332, 12339.197952133083, 12511.874881251435, 12613.810792838298, 12777.93611031939, 9958.804943406838, 9964.850527242243, 9976.90254072066, 10122.59509619607, 10794.838077429002, 10730.302530335503, 10772.299800512941, 10817.0, 11114.555417783198, 11185.496652650812, 10783.676489705322, 11058.22592418523, 11385.943070284928, 11398.658040258806, 11469.598564050219, 7702.768916932501, 7704.30661240491, 7811.336036436966, 7857.174996625272, 8134.918650813416, 9024.729258122266, 10806.35161890289, 10814.0, 11096.22326437174, 11124.555017799521], "unit": "score", "name": "jquery.html", "value": 8850.016652466988}, {"lowerIsBetter": false, "replicates": [1382.4470211915227, 1530.1584128729203, 1590.7772911792351, 1735.4533322003567, 1759.4018033868483, 8056.677732890685, 8485.618147183377, 8648.91351086489, 8682.262007729334, 8687.174718401757, 8445.155484451552, 8656.2642175415, 8683.522406267653, 8718.433301835375, 8721.7819554511, 2202.2292197730744, 2463.5442443147986, 2480.9503809923835, 2521.0924067335745, 2536.6195070739354, 2535.163396079289, 2537.314924970257, 2538.0228611984335, 2541.542522345977, 2548.872556372183, 2411.0958390603523, 2507.2227609441043, 2509.2723110297993, 2510.083819405913, 2510.2971168072877, 2444.095684596693, 2487.639292302615, 2511.9120830771017, 2514.5473814713346, 2514.7610976957344, 2474.938126546833, 2498.7376325485743, 2502.51201015802, 2511.937201569957, 2515.8742062896963, 8770.429922055046, 8776.561171941441, 8863.202311791969, 8869.778255543599, 8896.8665470018, 5509.118541033416, 5598.664080155204, 5614.522765564931, 5657.8585535361535, 5675.6878371689545, 3633.301488186101, 3721.5534135903595, 3762.1535154590274, 3771.4908487354132, 3772.5284339457567, 1044.3733759744168, 1061.9893801061967, 1070.0530030922612, 1080.7841178673991, 1083.6748975307376, 12143.574974875837, 12332.50669973209, 12346.320952347618, 12361.196522226117, 12366.62900112998, 4902.117618828645, 4902.828401005948, 4982.950170498249, 5015.724135172528, 5017.347744793154, 10501.474926253657, 10520.26358154937, 10537.0, 10543.736406589896, 10564.947175264075, 5612.438756124437, 5613.0, 5615.241942337732, 5625.09998400254, 5631.746571404296, 4441.933370999438, 4532.252178390529, 4592.425946756655, 4597.839075632337, 4844.781984810692, 3297.4394352960053, 3829.5596006459054, 3907.1794923066473, 3933.4296527003426, 3943.7633741975574, 1283.544341758681, 1323.4243104249683, 1330.2484096485455, 1335.9599212023654, 1343.1202562321696, 1326.7014921642553, 1337.1709540085014, 1346.5421756602802, 1398.9650258743409, 1402.0396028720359, 8122.75631731049, 8390.244877961013, 8395.454295470774, 8399.0, 8401.53791541471, 515.8839261166207, 519.888224031835, 530.0882482130729, 531.6544246239897, 533.0964015992855, 6192.442680158807, 6240.625562466266, 6282.654454004982, 6284.748610055638, 6289.056641503811, 10517.316374435637, 10824.07995320391, 10938.617148399768, 10940.890591093987, 10959.0684791792, 10405.167586593054, 10643.893561064291, 10720.35677859331, 10784.245102842882, 10794.082502987334, 8245.628946697412, 8361.665533378718, 8416.116307787717, 8427.41008129425, 8434.325253979667, 7716.228377162463, 7890.132085470479, 7912.406569507195, 7922.7227047053075, 7937.007874015748, 9420.434773913586, 9626.9037309626, 9628.807423851344, 9677.0, 9801.11789938909, 9755.609775608897, 10041.246906482189, 10127.291089623655, 10185.134263587383, 10209.132223760766, 7554.811129721801, 7558.0, 7607.809804754704, 7628.847423051397, 7658.8085297868, 6879.415249703831, 8262.091169971418, 8310.085890551914, 8323.95838020806, 8348.457350272212, 7342.155652099863, 7456.850862982818, 7464.402847772057, 7596.886046709194, 7610.9238907610215, 7349.375303099297, 7382.756705285063, 7448.627568621656, 7452.180260171268, 7524.134724506533, 7792.376609871083, 7825.843483130419, 7869.921300786918, 7879.369650427838, 7890.408219383684, 7046.4010559101, 7049.718011279491, 7118.181409138016, 7132.679029443584, 7134.072570565793, 7141.9642901785155, 7175.46184036189, 7218.025566548658, 7221.097362829646, 7229.783106506813], "unit": "score", "name": "mootools.html", "value": 4900.489868874488}, {"lowerIsBetter": false, "replicates": [324.3917654398004, 327.7410845432109, 330.57686161713013, 334.8827910231419, 337.5830848901606, 5694.54443644508, 5845.707714614268, 6309.369063093694, 6383.8509068367675, 6395.168628078343, 6146.170267013952, 6290.056491526273, 6305.0, 6432.807015789534, 6480.481561475082, 4473.306637471197, 4569.246074397721, 4593.104344652794, 4655.604273636728, 4740.69185502942, 4649.976750116261, 4714.222153344711, 4715.41057367829, 4723.433188017443, 4739.5023522530155, 4171.541130475645, 4252.638525725317, 4637.791299391535, 4652.604528615055, 4657.115148121863, 4448.4439445069365, 4494.730316181007, 4579.923717926301, 4590.517995610479, 4622.6070783983405, 4007.2586571484076, 4007.579204183548, 4010.2981978154, 4014.116894283253, 4028.1742242840146, 6057.061155520902, 6083.178770865965, 6097.237845269341, 6106.633601983851, 6119.969400153015, 5506.449355064502, 5507.586930980193, 5512.33851937766, 5515.669059856422, 5518.944810551883, 6733.259341472434, 6749.122614060141, 6771.559848609874, 6779.898301525481, 6782.932170678279, 4248.660107191417, 4414.514403415622, 4420.513743488214, 4422.601965823092, 4433.379326894237, 6958.756443524503, 7082.92917070833, 7115.608641524714, 7133.001379806831, 7138.0, 4455.086707225011, 4459.0858873930765, 4477.328400739915, 4479.037007043501, 4499.707519011319, 4525.343825145402, 4525.570070843265, 4533.32000199966, 4534.161180181677, 4545.772711364419, 5336.066188417011, 5345.091334473149, 5346.1713434417725, 5348.171033489815, 5351.839444816662, 6510.479161667055, 6718.899216511756, 6746.494012949049, 6759.155105611799, 6813.931860681429, 1544.9227538623024, 1551.1468692219235, 1559.0723519506103, 1563.234015332479, 1564.1709893756326, 819.7335865843505, 996.153269720746, 1020.285799940045, 1024.6925922223304, 1028.4703377760459, 5948.10778383246, 6071.9696401518595, 6108.5723999319625, 6230.439260466489, 6242.063690446378, 6945.305469453015, 6972.0, 6978.302169783083, 6982.650867456607, 6991.965040174767, 6183.690815459209, 6192.752289908443, 6192.845178870474, 6195.411435913581, 6250.6874656267, 3653.94519082214, 3715.498407714924, 3716.6097559756377, 3723.1064544509663, 3748.9250214995545, 5885.5585831062845, 6662.967240077795, 7092.929070709227, 7349.375303099189, 7375.963120184472, 6325.620462772156, 6576.44100251484, 6787.457003439713, 7252.564846109145, 7271.854562908712, 7332.853342933112, 7342.339189472973, 7348.301911318416, 7350.52221605594, 7410.814729631695, 6999.370056694922, 7016.19313778922, 7023.68393422287, 7025.824354391181, 7101.644917754195, 5571.637843540157, 6666.500012499179, 6929.618870962146, 6935.687894044881, 6936.687849046906, 7309.903514472871, 7353.0441042664115, 7358.080239970004, 7362.263773622595, 7371.447141464519, 4447.243968525294, 4453.910921781611, 4463.509014008521, 4464.933026004677, 4472.686911916135, 6960.756373526902, 6974.895376569254, 6976.581405115507, 7013.05323781283, 7039.788806335818, 6462.741490340334, 6681.098051763144, 6780.084688566981, 6783.830404239933, 6786.728530858908, 5201.7399130044105, 6681.09805176295, 6726.7981960541265, 6738.831529211809, 6766.627835469097, 5769.278840144982, 6177.9691101546005, 6584.8024559263295, 6598.307177746267, 6600.900986485302, 5397.541208997122, 6696.665166741741, 6705.698243578953, 6705.832354191184, 6715.0, 5295.629305948547, 6407.1350367701625, 6589.209294884645, 6601.53789234749, 6612.867742645024], "unit": "score", "name": "prototype.html", "value": 4902.569073570656}, {"lowerIsBetter": false, "replicates": [694.1462001737863, 740.93702035327, 750.193541942412, 760.9010828592283, 807.7334479621724, 15078.924605376971, 15275.694486110271, 15298.541043768677, 15301.46444874431, 15304.158271295075, 15787.526374208763, 16147.192640367964, 16163.434279800209, 16178.595535111628, 16229.188540572983, 735.3308489274762, 748.2517482517483, 912.0423555266959, 925.5788616179622, 933.8552524358702, 903.1961554216753, 918.2424499787669, 920.4753290624346, 921.262989608314, 921.4701546610692, 977.9315447918649, 978.7063880835757, 979.5591983607405, 983.1397527163732, 984.2863923655365, 761.6268028665913, 955.0544960489135, 969.9175570076552, 970.6554173268458, 974.0211087856729, 726.0234983946583, 727.439871299102, 727.5452841973766, 728.0135416510658, 729.3472342253706, 15267.541973740805, 15280.31238594266, 15388.692226155414, 15403.61490962735, 15466.5360039199, 12270.141090123694, 12337.444814983348, 12396.504139834396, 12589.622311330675, 12781.680457988532, 9846.96606856284, 10029.849552256723, 10103.343282686601, 10448.947755261252, 10975.83536246957, 3105.5186446100893, 3616.801199661469, 3638.1450359165574, 3649.233660931208, 3738.55137383513, 74934.62532687356, 79936.0, 80534.59732701357, 80968.0, 81277.59361203216, 7885.921140788633, 9087.182153606207, 9189.448633082036, 9553.331266811396, 9556.808863822824, 20590.27934022302, 20742.688859667116, 21058.78941210599, 21090.789092108884, 21104.894475527522, 7262.491625586158, 7446.106467223968, 7495.625218739041, 7498.4001279897475, 7565.130010048805, 3936.252112098692, 4070.6946978976694, 4137.8965525861495, 4162.937555936664, 4180.017695841475, 3653.5250417446096, 3706.295803797324, 3712.888613341604, 3716.925661486755, 3718.3121122592406, 660.1121491593799, 664.4617859533793, 679.341039191983, 680.829792551862, 682.4676752133344, 511.2254933775333, 562.1595714406988, 584.5995493087249, 598.3956204233755, 611.0986295214611, 7740.26467485588, 8160.551169685606, 8233.547154906537, 8287.378446616527, 8300.335973122135, 570.3127731084033, 577.7891069759507, 581.2937281203358, 597.9581429299907, 605.8636806718541, 3722.2927643748144, 3829.272438236726, 3873.9806300968316, 3874.3994680824517, 3900.356441187229, 71908.64045679843, 81595.0, 82535.17464825275, 82735.17264827275, 82880.58559707162, 76175.0, 76220.0, 76453.61773191098, 76600.46799063988, 78054.609726951, 61412.0, 64280.35719642837, 66849.65202783766, 70017.64991175216, 71227.64386178037, 6751.3248675134055, 7404.630143423484, 8081.232282933112, 8282.550553653207, 8402.537860417735, 38403.0, 46246.768766155954, 47898.04203915972, 48895.75552122359, 51841.22238166506, 65488.0, 69474.65262673654, 70407.59184816378, 70507.64746176236, 70547.64726176337, 10829.133669306279, 10946.890531094587, 11169.0, 11231.269967452416, 11446.771064578828, 11495.655130346104, 11903.166778325434, 11921.701957451132, 11925.880741192477, 12725.87274127247, 10050.24623153281, 11400.657980260605, 11538.307701537935, 11768.882311176778, 11861.76276474483, 11332.603358882729, 11433.142514311294, 11478.94260528692, 11561.190716649753, 11798.351090690094, 11155.553777848796, 11231.045361144394, 11233.831492527783, 11620.837916208311, 11701.824472632747, 9643.758906027406, 9722.75693107678, 9747.707568772948, 9814.2148628111, 9918.30571859963, 8706.869396958924, 8926.553672316488, 9220.677276295297, 9324.580393882155, 9811.411315320818], "unit": "score", "name": "yui.html", "value": 6889.307246170544}], "name": "dromaeo_css", "value": 7313.104494118297}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 114.0, 115.0, 156.0, 168.0, 118.0, 113.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 122.7}, {"lowerIsBetter": true, "replicates": [156.0, 126.0, 132.0, 189.0, 147.0, 147.0, 163.0, 148.0, 168.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [186.0, 183.0, 184.0, 182.0, 181.0, 184.0, 179.0, 182.0, 181.0, 182.0], "unit": "score", "name": "audio-dft", "value": 182.4}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 88.0, 82.0, 55.0, 58.0, 57.0, 79.0, 79.0, 58.0], "unit": "score", "name": "audio-fft", "value": 70.9}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 128.0, 80.0, 77.0, 89.0, 114.0, 78.0, 78.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 94.8}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 86.0, 84.0, 87.0, 83.0, 87.0, 84.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 92.0, 92.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 92.9}, {"lowerIsBetter": true, "replicates": [127.0, 140.0, 94.0, 83.0, 88.0, 84.0, 105.0, 143.0, 140.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 109.0}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 56.0, 56.0, 54.0, 54.0, 53.0, 65.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 71.0, 79.0, 70.0, 67.0, 67.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 84.0, 83.0, 84.0, 82.0, 83.0, 81.0, 82.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [124.0, 133.0, 131.0, 135.0, 119.0, 125.0, 126.0, 111.0, 146.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [141.0, 139.0, 132.0, 141.0, 140.0, 156.0, 165.0, 180.0, 135.0, 127.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 69.0, 68.0, 68.0, 69.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1453.4999999999998}]} 11:49:28 INFO - Return code: 0 11:49:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:49:28 ERROR - # TBPL SUCCESS # 11:49:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:49:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:49:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:49:28 INFO - 2016-03-30 11:49:28.364 screenresolution[1681:9972] starting screenresolution argv=screenresolution get 11:49:28 INFO - 2016-03-30 11:49:28.366 screenresolution[1681:9972] Display 0: 1600x1200x32@60 11:49:28 INFO - 2016-03-30 11:49:28.372 screenresolution[1682:9975] starting screenresolution argv=screenresolution list 11:49:28 INFO - Available Modes on Display 0 11:49:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:49:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:49:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:49:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:49:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:49:28 INFO - Intel Iris: 11:49:28 INFO - Chipset Model: Intel Iris 11:49:28 INFO - Type: GPU 11:49:28 INFO - Bus: Built-In 11:49:28 INFO - VRAM (Dynamic, Max): 1536 MB 11:49:28 INFO - Vendor: Intel (0x8086) 11:49:28 INFO - Device ID: 0x0a2e 11:49:28 INFO - Revision ID: 0x0009 11:49:28 INFO - Displays: 11:49:28 INFO - Display: 11:49:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:49:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:49:28 INFO - Display Serial Number: 1600x1200 60 11:49:28 INFO - Main Display: Yes 11:49:28 INFO - Mirror: Off 11:49:28 INFO - Online: Yes 11:49:28 INFO - Rotation: Supported 11:49:28 INFO - Return code: 0 11:49:28 INFO - Running post-action listener: _resource_record_post_action 11:49:28 INFO - Running post-run listener: _resource_record_post_run 11:49:29 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39507456; Write bytes: 708070912; Read time: 426; Write time: 2118 11:49:29 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391217664; Write bytes: 381671424; Read time: 30025; Write time: 702 11:49:29 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 33263104; Write bytes: 301442560; Read time: 345; Write time: 1363 11:49:29 INFO - Running post-run listener: _upload_blobber_files 11:49:29 INFO - Blob upload gear active. 11:49:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:49:29 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 11:49:29 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'] 11:49:29 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 11:49:30 INFO - (blobuploader) - INFO - Open directory for files ... 11:49:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:49:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:49:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:49:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:49:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:49:32 INFO - (blobuploader) - INFO - Done attempting. 11:49:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:49:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:49:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:49:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:49:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:49:34 INFO - (blobuploader) - INFO - Done attempting. 11:49:34 INFO - (blobuploader) - INFO - Iteration through files over. 11:49:34 INFO - Return code: 0 11:49:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:49:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:49:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bc9123145bb0d169e57cc18dfc0f32863ad7c28554c52aa1cbe4b486283e54874068f3573f417a1b7e48da2a346e5df611e54310ca277ac20fb93dce17c2ee4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d02eedef4ee4238eaf950e0d2ff2e81d79cabd5fa023c2544211d5a281bf7c2734b32612360a77fbef1894c0d3fd3eb47e9752a99d1694146d3a6425998f8778"} 11:49:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:49:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:49:34 INFO - Contents: 11:49:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bc9123145bb0d169e57cc18dfc0f32863ad7c28554c52aa1cbe4b486283e54874068f3573f417a1b7e48da2a346e5df611e54310ca277ac20fb93dce17c2ee4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d02eedef4ee4238eaf950e0d2ff2e81d79cabd5fa023c2544211d5a281bf7c2734b32612360a77fbef1894c0d3fd3eb47e9752a99d1694146d3a6425998f8778"} 11:49:34 INFO - Running post-run listener: copy_logs_to_upload_dir 11:49:34 INFO - Copying logs to upload dir... 11:49:34 INFO - mkdir: /builds/slave/test/build/upload/logs 11:49:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.063856 ========= master_lag: 3.77 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-03-30 11:49:38.073858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 11:49:38.077594) ========= 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.bLHE2rwU7S/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.gqo18YLhoV/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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/0bc9123145bb0d169e57cc18dfc0f32863ad7c28554c52aa1cbe4b486283e54874068f3573f417a1b7e48da2a346e5df611e54310ca277ac20fb93dce17c2ee4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d02eedef4ee4238eaf950e0d2ff2e81d79cabd5fa023c2544211d5a281bf7c2734b32612360a77fbef1894c0d3fd3eb47e9752a99d1694146d3a6425998f8778"} build_url:https://queue.taskcluster.net/v1/task/EAIxdzxISt2FY5h1T8fkKQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011014 build_url: 'https://queue.taskcluster.net/v1/task/EAIxdzxISt2FY5h1T8fkKQ/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/0bc9123145bb0d169e57cc18dfc0f32863ad7c28554c52aa1cbe4b486283e54874068f3573f417a1b7e48da2a346e5df611e54310ca277ac20fb93dce17c2ee4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d02eedef4ee4238eaf950e0d2ff2e81d79cabd5fa023c2544211d5a281bf7c2734b32612360a77fbef1894c0d3fd3eb47e9752a99d1694146d3a6425998f8778"}' ========= master_lag: 0.63 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 11:49:38.719979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 11:49:38.720437) ========= 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.bLHE2rwU7S/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.gqo18YLhoV/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005119 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 11:49:38.849868) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 11:49:38.850230) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 11:49:38.850716) ========= ========= Total master_lag: 4.70 =========